builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1475674654.99 results: success (0) buildid: 20161005033001 builduid: 4aea672fe9d841d9a0478930a9e29ce4 revision: c4a811b0531e3bf4279a1e19a3e4451f2e416719 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:34.987956) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:34.988405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:34.988691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:35.003196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:35.003463) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 06:37:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.6M=0s 2016-10-05 06:37:36 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128481 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:35.145542) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:35.145889) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018936 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:35.195452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:35.195809) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a811b0531e3bf4279a1e19a3e4451f2e416719 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c4a811b0531e3bf4279a1e19a3e4451f2e416719 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 06:37:36,268 truncating revision to first 12 chars 2016-10-05 06:37:36,268 Setting DEBUG logging. 2016-10-05 06:37:36,268 attempt 1/10 2016-10-05 06:37:36,268 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a811b0531e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 06:37:36,790 unpacking tar archive at: fx-team-c4a811b0531e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:36.130704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:36.131049) ========= script_repo_revision: c4a811b0531e3bf4279a1e19a3e4451f2e416719 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:36.131459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:36.131752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:36.141636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-05 06:37:36.141927) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:37:37 INFO - MultiFileLogger online at 20161005 06:37:37 in /builds/slave/test 06:37:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:37:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:37:37 INFO - {'append_to_log': False, 06:37:37 INFO - 'base_work_dir': '/builds/slave/test', 06:37:37 INFO - 'blob_upload_branch': 'Fx-Team', 06:37:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:37:37 INFO - 'branch': 'Fx-Team', 06:37:37 INFO - 'buildbot_json_path': 'buildprops.json', 06:37:37 INFO - 'config_files': ('talos/linux_config.py',), 06:37:37 INFO - 'default_actions': ('clobber', 06:37:37 INFO - 'read-buildbot-config', 06:37:37 INFO - 'download-and-extract', 06:37:37 INFO - 'populate-webroot', 06:37:37 INFO - 'create-virtualenv', 06:37:37 INFO - 'install', 06:37:37 INFO - 'run-tests'), 06:37:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:37:37 INFO - 'download_minidump_stackwalk': True, 06:37:37 INFO - 'download_symbols': 'ondemand', 06:37:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:37:37 INFO - 'tooltool.py': '/tools/tooltool.py', 06:37:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:37:37 INFO - '/tools/misc-python/virtualenv.py')}, 06:37:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:37:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:37:37 INFO - 'installer_path': 'installer.exe', 06:37:37 INFO - 'log_level': 'info', 06:37:37 INFO - 'log_name': 'talos', 06:37:37 INFO - 'log_to_console': True, 06:37:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:37:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:37:37 INFO - 'opt_config_files': (), 06:37:37 INFO - 'pip_index': False, 06:37:37 INFO - 'sps_profile': False, 06:37:37 INFO - 'sps_profile_interval': 0, 06:37:37 INFO - 'suite': 'dromaeojs', 06:37:37 INFO - 'system_bits': '32', 06:37:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:37:37 INFO - 'title': 'talos-linux64-ix-028', 06:37:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:37:37 INFO - 'use_talos_json': True, 06:37:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:37:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:37:37 INFO - 'work_dir': 'build'} 06:37:37 INFO - [mozharness: 2016-10-05 13:37:37.308068Z] Running clobber step. 06:37:37 INFO - Running pre-action listener: _resource_record_pre_action 06:37:37 INFO - Running main action method: clobber 06:37:37 INFO - rmtree: /builds/slave/test/build 06:37:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:37:37 INFO - Running post-action listener: _resource_record_post_action 06:37:37 INFO - [mozharness: 2016-10-05 13:37:37.770360Z] Finished clobber step (success) 06:37:37 INFO - [mozharness: 2016-10-05 13:37:37.770459Z] Running read-buildbot-config step. 06:37:37 INFO - Running pre-action listener: _resource_record_pre_action 06:37:37 INFO - Running main action method: read_buildbot_config 06:37:37 INFO - Using buildbot properties: 06:37:37 INFO - { 06:37:37 INFO - "project": "", 06:37:37 INFO - "product": "firefox", 06:37:37 INFO - "script_repo_revision": "production", 06:37:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:37:37 INFO - "repository": "", 06:37:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:37:37 INFO - "buildid": "20161005033001", 06:37:37 INFO - "pgo_build": "True", 06:37:37 INFO - "basedir": "/builds/slave/test", 06:37:37 INFO - "buildnumber": 1108, 06:37:37 INFO - "slavename": "talos-linux64-ix-028", 06:37:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:37:37 INFO - "platform": "ubuntu64_hw", 06:37:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:37:37 INFO - "branch": "fx-team", 06:37:37 INFO - "repo_path": "integration/fx-team", 06:37:37 INFO - "revision": "c4a811b0531e3bf4279a1e19a3e4451f2e416719", 06:37:37 INFO - "stage_platform": "linux64-pgo", 06:37:37 INFO - "builduid": "4aea672fe9d841d9a0478930a9e29ce4", 06:37:37 INFO - "slavebuilddir": "test" 06:37:37 INFO - } 06:37:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:37:37 INFO - Running post-action listener: _resource_record_post_action 06:37:37 INFO - [mozharness: 2016-10-05 13:37:37.772873Z] Finished read-buildbot-config step (success) 06:37:37 INFO - [mozharness: 2016-10-05 13:37:37.772961Z] Running download-and-extract step. 06:37:37 INFO - Running pre-action listener: _resource_record_pre_action 06:37:37 INFO - Running main action method: download_and_extract 06:37:37 INFO - mkdir: /builds/slave/test/build/tests 06:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:37 INFO - trying https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:37:38 INFO - Downloaded 1361 bytes. 06:37:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:37:38 INFO - Using the following test package requirements: 06:37:38 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:38 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:37:38 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:37:38 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'jsshell-linux-x86_64.zip'], 06:37:38 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:37:38 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:38 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:37:38 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:37:38 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:37:38 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:37:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:37:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:37:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:37:38 INFO - Fetch https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:37:38 INFO - Http code: 200 06:37:38 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 06:37:38 INFO - x-amz-cf-id: nEF77kOA3yfII3kpmQ9I0QlJV0Rsf0jjIyBNs-uhKy9_1Yzl9keqfA== 06:37:38 INFO - x-amz-version-id: 4q9sVvhjJz4ieXydt4SVCDfL0Pgf5wD6 06:37:39 INFO - Expected file size: 21992733 06:37:39 INFO - Obtained file size: 21992733 06:37:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:37:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:37:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:37:43 INFO - Fetch https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:37:43 INFO - Http code: 200 06:37:43 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 06:37:43 INFO - x-amz-cf-id: YxXIImR0kkki890kwSVN5oqz7ZBxBj09RxbdgejU9x5E1-mRyw8PxA== 06:37:43 INFO - x-amz-version-id: 4q9sVvhjJz4ieXydt4SVCDfL0Pgf5wD6 06:37:44 INFO - Expected file size: 21992733 06:37:44 INFO - Obtained file size: 21992733 06:37:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:37:48 INFO - Fetch https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:37:49 INFO - Http code: 200 06:37:49 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 06:37:49 INFO - x-amz-cf-id: aWQNy_H9COeE_bHKUjd8PiXJDnBHMZxRUQLoeAyRH8PNu8MClpsv-Q== 06:37:49 INFO - x-amz-version-id: Tsyc.moTbDtPa8AVr4uGFjFehRPIJKxm 06:37:49 INFO - Expected file size: 14409006 06:37:49 INFO - Obtained file size: 14409006 06:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:49 INFO - trying https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:37:49 INFO - Downloading https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:37:50 INFO - Downloaded 59709533 bytes. 06:37:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:37:50 INFO - mkdir: /builds/slave/test/properties 06:37:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:50 INFO - Contents: 06:37:50 INFO - build_url:https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:37:51 INFO - Running post-action listener: _resource_record_post_action 06:37:51 INFO - Running post-action listener: set_extra_try_arguments 06:37:51 INFO - [mozharness: 2016-10-05 13:37:51.310836Z] Finished download-and-extract step (success) 06:37:51 INFO - [mozharness: 2016-10-05 13:37:51.311060Z] Running populate-webroot step. 06:37:51 INFO - Running pre-action listener: _resource_record_pre_action 06:37:51 INFO - Running main action method: populate_webroot 06:37:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:51 INFO - '--tppagecycles', 06:37:51 INFO - '7'], 06:37:51 INFO - 'tests': ['tsvgm']}}, 06:37:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['damp', 'tps']}, 06:37:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'tests': ['damp', 'tps']}, 06:37:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['dromaeo_dom']}, 06:37:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['basic_compositor_video']}, 06:37:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:37:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['a11yr', 06:37:51 INFO - 'ts_paint', 06:37:51 INFO - 'tpaint', 06:37:51 INFO - 'sessionrestore', 06:37:51 INFO - 'sessionrestore_no_auto_restore', 06:37:51 INFO - 'tabpaint']}, 06:37:51 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:51 INFO - 'ts_paint', 06:37:51 INFO - 'tpaint', 06:37:51 INFO - 'sessionrestore', 06:37:51 INFO - 'sessionrestore_no_auto_restore', 06:37:51 INFO - 'tabpaint']}, 06:37:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:51 INFO - 'ts_paint', 06:37:51 INFO - 'tpaint', 06:37:51 INFO - 'sessionrestore', 06:37:51 INFO - 'sessionrestore_no_auto_restore', 06:37:51 INFO - 'tabpaint']}, 06:37:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:51 INFO - 'ts_paint', 06:37:51 INFO - 'tpaint', 06:37:51 INFO - 'sessionrestore', 06:37:51 INFO - 'sessionrestore_no_auto_restore', 06:37:51 INFO - 'tabpaint']}, 06:37:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['a11yr', 06:37:51 INFO - 'ts_paint', 06:37:51 INFO - 'tpaint', 06:37:51 INFO - 'sessionrestore', 06:37:51 INFO - 'sessionrestore_no_auto_restore', 06:37:51 INFO - 'tabpaint']}, 06:37:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['a11yr', 06:37:51 INFO - 'ts_paint', 06:37:51 INFO - 'tpaint', 06:37:51 INFO - 'sessionrestore', 06:37:51 INFO - 'sessionrestore_no_auto_restore', 06:37:51 INFO - 'tabpaint']}, 06:37:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['tsvgx', 06:37:51 INFO - 'tsvgr_opacity', 06:37:51 INFO - 'tart', 06:37:51 INFO - 'tscrollx', 06:37:51 INFO - 'cart']}, 06:37:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:51 INFO - 'tsvgr_opacity', 06:37:51 INFO - 'tart', 06:37:51 INFO - 'tscrollx', 06:37:51 INFO - 'cart']}, 06:37:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'talos_options': ['--disable-e10s'], 06:37:51 INFO - 'tests': ['tp5o']}, 06:37:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'tests': ['tp5o']}, 06:37:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'talos_options': ['--disable-e10s', 06:37:51 INFO - '--xperf_path', 06:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:51 INFO - 'tests': ['tp5n']}, 06:37:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:51 INFO - 'talos_options': ['--xperf_path', 06:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:51 INFO - 'tests': ['tp5n']}}, 06:37:51 INFO - 'talos.zip': {'path': '', 06:37:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:51 INFO - Running post-action listener: _resource_record_post_action 06:37:51 INFO - [mozharness: 2016-10-05 13:37:51.330667Z] Finished populate-webroot step (success) 06:37:51 INFO - [mozharness: 2016-10-05 13:37:51.330753Z] Running create-virtualenv step. 06:37:51 INFO - Running pre-action listener: _resource_record_pre_action 06:37:51 INFO - Running main action method: create_virtualenv 06:37:51 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:37:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:51 INFO - Using real prefix '/usr' 06:37:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:53 INFO - Installing pip.................done. 06:37:53 INFO - Return code: 0 06:37:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:37:54 INFO - Reading from file tmpfile_stdout 06:37:54 INFO - Output received: 06:37:54 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:37:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:37:54 INFO - Using env: {'DISPLAY': ':0', 06:37:54 INFO - 'HOME': '/home/cltbld', 06:37:54 INFO - 'LANG': 'en_US.UTF-8', 06:37:54 INFO - 'LANGUAGE': 'en_US:en', 06:37:54 INFO - 'LOGNAME': 'cltbld', 06:37:54 INFO - 'MAIL': '/var/mail/cltbld', 06:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:54 INFO - 'MOZ_NO_REMOTE': '1', 06:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:54 INFO - 'NO_EM_RESTART': '1', 06:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:54 INFO - 'PWD': '/builds/slave/test', 06:37:54 INFO - 'SHELL': '/bin/bash', 06:37:54 INFO - 'SHLVL': '1', 06:37:54 INFO - 'TERM': 'linux', 06:37:54 INFO - 'TMOUT': '86400', 06:37:54 INFO - 'USER': 'cltbld', 06:37:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:54 INFO - '_': '/tools/buildbot/bin/python'} 06:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:37:54 INFO - Cleaning up... 06:37:54 INFO - Return code: 0 06:37:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:37:54 INFO - Using env: {'DISPLAY': ':0', 06:37:54 INFO - 'HOME': '/home/cltbld', 06:37:54 INFO - 'LANG': 'en_US.UTF-8', 06:37:54 INFO - 'LANGUAGE': 'en_US:en', 06:37:54 INFO - 'LOGNAME': 'cltbld', 06:37:54 INFO - 'MAIL': '/var/mail/cltbld', 06:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:54 INFO - 'MOZ_NO_REMOTE': '1', 06:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:54 INFO - 'NO_EM_RESTART': '1', 06:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:54 INFO - 'PWD': '/builds/slave/test', 06:37:54 INFO - 'SHELL': '/bin/bash', 06:37:54 INFO - 'SHLVL': '1', 06:37:54 INFO - 'TERM': 'linux', 06:37:54 INFO - 'TMOUT': '86400', 06:37:54 INFO - 'USER': 'cltbld', 06:37:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:54 INFO - '_': '/tools/buildbot/bin/python'} 06:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:54 INFO - Downloading/unpacking psutil>=3.1.1 06:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:56 INFO - Installing collected packages: psutil 06:37:56 INFO - Running setup.py install for psutil 06:37:56 INFO - building 'psutil._psutil_linux' extension 06:37:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:37:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:37:56 INFO - building 'psutil._psutil_posix' extension 06:37:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:37:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:57 INFO - Successfully installed psutil 06:37:57 INFO - Cleaning up... 06:37:57 INFO - Return code: 0 06:37:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:37:57 INFO - Using env: {'DISPLAY': ':0', 06:37:57 INFO - 'HOME': '/home/cltbld', 06:37:57 INFO - 'LANG': 'en_US.UTF-8', 06:37:57 INFO - 'LANGUAGE': 'en_US:en', 06:37:57 INFO - 'LOGNAME': 'cltbld', 06:37:57 INFO - 'MAIL': '/var/mail/cltbld', 06:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:57 INFO - 'MOZ_NO_REMOTE': '1', 06:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:57 INFO - 'NO_EM_RESTART': '1', 06:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:57 INFO - 'PWD': '/builds/slave/test', 06:37:57 INFO - 'SHELL': '/bin/bash', 06:37:57 INFO - 'SHLVL': '1', 06:37:57 INFO - 'TERM': 'linux', 06:37:57 INFO - 'TMOUT': '86400', 06:37:57 INFO - 'USER': 'cltbld', 06:37:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:57 INFO - '_': '/tools/buildbot/bin/python'} 06:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:37:59 INFO - Installing collected packages: mozsystemmonitor 06:37:59 INFO - Running setup.py install for mozsystemmonitor 06:37:59 INFO - Successfully installed mozsystemmonitor 06:37:59 INFO - Cleaning up... 06:37:59 INFO - Return code: 0 06:37:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:37:59 INFO - Using env: {'DISPLAY': ':0', 06:37:59 INFO - 'HOME': '/home/cltbld', 06:37:59 INFO - 'LANG': 'en_US.UTF-8', 06:37:59 INFO - 'LANGUAGE': 'en_US:en', 06:37:59 INFO - 'LOGNAME': 'cltbld', 06:37:59 INFO - 'MAIL': '/var/mail/cltbld', 06:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:59 INFO - 'MOZ_NO_REMOTE': '1', 06:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:59 INFO - 'NO_EM_RESTART': '1', 06:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:59 INFO - 'PWD': '/builds/slave/test', 06:37:59 INFO - 'SHELL': '/bin/bash', 06:37:59 INFO - 'SHLVL': '1', 06:37:59 INFO - 'TERM': 'linux', 06:37:59 INFO - 'TMOUT': '86400', 06:37:59 INFO - 'USER': 'cltbld', 06:37:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:59 INFO - '_': '/tools/buildbot/bin/python'} 06:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:59 INFO - Downloading/unpacking jsonschema==2.5.1 06:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:01 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:01 INFO - warning: no files found matching '*.txt' 06:38:01 INFO - no previously-included directories found matching 'build' 06:38:01 INFO - no previously-included directories found matching 'dist' 06:38:01 INFO - no previously-included directories found matching '.git*' 06:38:01 INFO - Installing collected packages: jsonschema, functools32 06:38:01 INFO - Running setup.py install for functools32 06:38:01 INFO - warning: no files found matching '*.txt' 06:38:01 INFO - no previously-included directories found matching 'build' 06:38:01 INFO - no previously-included directories found matching 'dist' 06:38:01 INFO - no previously-included directories found matching '.git*' 06:38:02 INFO - Successfully installed jsonschema functools32 06:38:02 INFO - Cleaning up... 06:38:02 INFO - Return code: 0 06:38:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:38:02 INFO - Using env: {'DISPLAY': ':0', 06:38:02 INFO - 'HOME': '/home/cltbld', 06:38:02 INFO - 'LANG': 'en_US.UTF-8', 06:38:02 INFO - 'LANGUAGE': 'en_US:en', 06:38:02 INFO - 'LOGNAME': 'cltbld', 06:38:02 INFO - 'MAIL': '/var/mail/cltbld', 06:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:02 INFO - 'MOZ_NO_REMOTE': '1', 06:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:02 INFO - 'NO_EM_RESTART': '1', 06:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:02 INFO - 'PWD': '/builds/slave/test', 06:38:02 INFO - 'SHELL': '/bin/bash', 06:38:02 INFO - 'SHLVL': '1', 06:38:02 INFO - 'TERM': 'linux', 06:38:02 INFO - 'TMOUT': '86400', 06:38:02 INFO - 'USER': 'cltbld', 06:38:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:02 INFO - '_': '/tools/buildbot/bin/python'} 06:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:38:02 INFO - Cleaning up... 06:38:02 INFO - Return code: 0 06:38:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:38:02 INFO - Using env: {'DISPLAY': ':0', 06:38:02 INFO - 'HOME': '/home/cltbld', 06:38:02 INFO - 'LANG': 'en_US.UTF-8', 06:38:02 INFO - 'LANGUAGE': 'en_US:en', 06:38:02 INFO - 'LOGNAME': 'cltbld', 06:38:02 INFO - 'MAIL': '/var/mail/cltbld', 06:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:02 INFO - 'MOZ_NO_REMOTE': '1', 06:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:02 INFO - 'NO_EM_RESTART': '1', 06:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:02 INFO - 'PWD': '/builds/slave/test', 06:38:02 INFO - 'SHELL': '/bin/bash', 06:38:02 INFO - 'SHLVL': '1', 06:38:02 INFO - 'TERM': 'linux', 06:38:02 INFO - 'TMOUT': '86400', 06:38:02 INFO - 'USER': 'cltbld', 06:38:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:02 INFO - '_': '/tools/buildbot/bin/python'} 06:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:02 INFO - Downloading/unpacking blobuploader==1.2.4 06:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:38:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:05 INFO - Downloading docopt-0.6.1.tar.gz 06:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:05 INFO - Running setup.py install for blobuploader 06:38:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:38:05 INFO - Running setup.py install for requests 06:38:05 INFO - Running setup.py install for docopt 06:38:05 INFO - Successfully installed blobuploader requests docopt 06:38:05 INFO - Cleaning up... 06:38:05 INFO - Return code: 0 06:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:05 INFO - Using env: {'DISPLAY': ':0', 06:38:05 INFO - 'HOME': '/home/cltbld', 06:38:05 INFO - 'LANG': 'en_US.UTF-8', 06:38:05 INFO - 'LANGUAGE': 'en_US:en', 06:38:05 INFO - 'LOGNAME': 'cltbld', 06:38:05 INFO - 'MAIL': '/var/mail/cltbld', 06:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:05 INFO - 'MOZ_NO_REMOTE': '1', 06:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:05 INFO - 'NO_EM_RESTART': '1', 06:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:05 INFO - 'PWD': '/builds/slave/test', 06:38:05 INFO - 'SHELL': '/bin/bash', 06:38:05 INFO - 'SHLVL': '1', 06:38:05 INFO - 'TERM': 'linux', 06:38:05 INFO - 'TMOUT': '86400', 06:38:05 INFO - 'USER': 'cltbld', 06:38:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:05 INFO - '_': '/tools/buildbot/bin/python'} 06:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:06 INFO - Running setup.py (path:/tmp/pip-3iAdkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:06 INFO - Running setup.py (path:/tmp/pip-ubCNAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:06 INFO - Running setup.py (path:/tmp/pip-bqYQpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:06 INFO - Running setup.py (path:/tmp/pip-w7Kr1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:06 INFO - Running setup.py (path:/tmp/pip-fKIs8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:06 INFO - Running setup.py (path:/tmp/pip-UU0jAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:06 INFO - Running setup.py (path:/tmp/pip-8UHNMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:06 INFO - Running setup.py (path:/tmp/pip-3PPpwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:06 INFO - Running setup.py (path:/tmp/pip-WS58P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:06 INFO - Running setup.py (path:/tmp/pip-vUuS19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:06 INFO - Running setup.py (path:/tmp/pip-kKZaYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:06 INFO - Running setup.py (path:/tmp/pip-5N4k4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:06 INFO - Running setup.py (path:/tmp/pip-cRbxiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:06 INFO - Running setup.py (path:/tmp/pip-err06V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:07 INFO - Running setup.py (path:/tmp/pip-_gvm5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:07 INFO - Running setup.py (path:/tmp/pip-ZknG8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:07 INFO - Running setup.py (path:/tmp/pip-5IGSNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:07 INFO - Running setup.py install for manifestparser 06:38:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:38:07 INFO - Running setup.py install for mozcrash 06:38:07 INFO - Running setup.py install for mozdebug 06:38:07 INFO - Running setup.py install for mozdevice 06:38:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:38:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:38:07 INFO - Running setup.py install for mozfile 06:38:07 INFO - Running setup.py install for mozhttpd 06:38:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:38:07 INFO - Running setup.py install for mozinfo 06:38:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:38:07 INFO - Running setup.py install for mozInstall 06:38:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Running setup.py install for mozleak 06:38:08 INFO - Running setup.py install for mozlog 06:38:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Running setup.py install for moznetwork 06:38:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Running setup.py install for mozprocess 06:38:08 INFO - Running setup.py install for mozprofile 06:38:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Running setup.py install for mozrunner 06:38:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:38:08 INFO - Running setup.py install for mozscreenshot 06:38:08 INFO - Running setup.py install for moztest 06:38:08 INFO - Running setup.py install for mozversion 06:38:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:38:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:09 INFO - Cleaning up... 06:38:09 INFO - Return code: 0 06:38:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:09 INFO - Using env: {'DISPLAY': ':0', 06:38:09 INFO - 'HOME': '/home/cltbld', 06:38:09 INFO - 'LANG': 'en_US.UTF-8', 06:38:09 INFO - 'LANGUAGE': 'en_US:en', 06:38:09 INFO - 'LOGNAME': 'cltbld', 06:38:09 INFO - 'MAIL': '/var/mail/cltbld', 06:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:09 INFO - 'MOZ_NO_REMOTE': '1', 06:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:09 INFO - 'NO_EM_RESTART': '1', 06:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:09 INFO - 'PWD': '/builds/slave/test', 06:38:09 INFO - 'SHELL': '/bin/bash', 06:38:09 INFO - 'SHLVL': '1', 06:38:09 INFO - 'TERM': 'linux', 06:38:09 INFO - 'TMOUT': '86400', 06:38:09 INFO - 'USER': 'cltbld', 06:38:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:09 INFO - '_': '/tools/buildbot/bin/python'} 06:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:09 INFO - Running setup.py (path:/tmp/pip-gY3OBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:09 INFO - Running setup.py (path:/tmp/pip-Pvdbvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:09 INFO - Running setup.py (path:/tmp/pip-uRxXLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:09 INFO - Running setup.py (path:/tmp/pip-VD1fHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:09 INFO - Running setup.py (path:/tmp/pip-tfsriH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:09 INFO - Running setup.py (path:/tmp/pip-aDLsbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:09 INFO - Running setup.py (path:/tmp/pip-CaHZAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:09 INFO - Running setup.py (path:/tmp/pip-3VIY3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:09 INFO - Running setup.py (path:/tmp/pip-ivHpSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:09 INFO - Running setup.py (path:/tmp/pip-r8ou3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:10 INFO - Running setup.py (path:/tmp/pip-_bdkrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:10 INFO - Running setup.py (path:/tmp/pip-p4QhAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:10 INFO - Running setup.py (path:/tmp/pip-aTGlv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:10 INFO - Running setup.py (path:/tmp/pip-f6I30O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:10 INFO - Running setup.py (path:/tmp/pip-9lXbFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:10 INFO - Running setup.py (path:/tmp/pip-ZWp6FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:10 INFO - Running setup.py (path:/tmp/pip-1lIN43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:38:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:12 INFO - Downloading blessings-1.6.tar.gz 06:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:12 INFO - Installing collected packages: blessings 06:38:12 INFO - Running setup.py install for blessings 06:38:12 INFO - Successfully installed blessings 06:38:12 INFO - Cleaning up... 06:38:12 INFO - Return code: 0 06:38:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:12 INFO - Reading from file tmpfile_stdout 06:38:12 INFO - Current package versions: 06:38:12 INFO - argparse == 1.2.1 06:38:12 INFO - blessings == 1.6 06:38:12 INFO - blobuploader == 1.2.4 06:38:12 INFO - docopt == 0.6.1 06:38:12 INFO - functools32 == 3.2.3-2 06:38:12 INFO - jsonschema == 2.5.1 06:38:12 INFO - manifestparser == 1.1 06:38:12 INFO - mozInstall == 1.12 06:38:12 INFO - mozcrash == 0.17 06:38:12 INFO - mozdebug == 0.1 06:38:12 INFO - mozdevice == 0.48 06:38:12 INFO - mozfile == 1.2 06:38:12 INFO - mozhttpd == 0.7 06:38:12 INFO - mozinfo == 0.9 06:38:12 INFO - mozleak == 0.1 06:38:12 INFO - mozlog == 3.4 06:38:12 INFO - moznetwork == 0.27 06:38:12 INFO - mozprocess == 0.23 06:38:12 INFO - mozprofile == 0.28 06:38:12 INFO - mozrunner == 6.12 06:38:12 INFO - mozscreenshot == 0.1 06:38:12 INFO - mozsystemmonitor == 0.3 06:38:12 INFO - moztest == 0.7 06:38:12 INFO - mozversion == 1.4 06:38:12 INFO - psutil == 3.1.1 06:38:12 INFO - requests == 1.2.3 06:38:12 INFO - wsgiref == 0.1.2 06:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:12 INFO - Using env: {'DISPLAY': ':0', 06:38:12 INFO - 'HOME': '/home/cltbld', 06:38:12 INFO - 'LANG': 'en_US.UTF-8', 06:38:12 INFO - 'LANGUAGE': 'en_US:en', 06:38:12 INFO - 'LOGNAME': 'cltbld', 06:38:12 INFO - 'MAIL': '/var/mail/cltbld', 06:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:12 INFO - 'MOZ_NO_REMOTE': '1', 06:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:12 INFO - 'NO_EM_RESTART': '1', 06:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:12 INFO - 'PWD': '/builds/slave/test', 06:38:12 INFO - 'SHELL': '/bin/bash', 06:38:12 INFO - 'SHLVL': '1', 06:38:12 INFO - 'TERM': 'linux', 06:38:12 INFO - 'TMOUT': '86400', 06:38:12 INFO - 'USER': 'cltbld', 06:38:12 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:12 INFO - '_': '/tools/buildbot/bin/python'} 06:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:38:13 INFO - Cleaning up... 06:38:13 INFO - Return code: 0 06:38:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a6a48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf057b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:38:13 INFO - Using env: {'DISPLAY': ':0', 06:38:13 INFO - 'HOME': '/home/cltbld', 06:38:13 INFO - 'LANG': 'en_US.UTF-8', 06:38:13 INFO - 'LANGUAGE': 'en_US:en', 06:38:13 INFO - 'LOGNAME': 'cltbld', 06:38:13 INFO - 'MAIL': '/var/mail/cltbld', 06:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:13 INFO - 'MOZ_NO_REMOTE': '1', 06:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:13 INFO - 'NO_EM_RESTART': '1', 06:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:13 INFO - 'PWD': '/builds/slave/test', 06:38:13 INFO - 'SHELL': '/bin/bash', 06:38:13 INFO - 'SHLVL': '1', 06:38:13 INFO - 'TERM': 'linux', 06:38:13 INFO - 'TMOUT': '86400', 06:38:13 INFO - 'USER': 'cltbld', 06:38:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:13 INFO - '_': '/tools/buildbot/bin/python'} 06:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:38:13 INFO - Cleaning up... 06:38:13 INFO - Return code: 0 06:38:13 INFO - Running post-action listener: _resource_record_post_action 06:38:13 INFO - Running post-action listener: _start_resource_monitoring 06:38:13 INFO - Starting resource monitoring. 06:38:13 INFO - [mozharness: 2016-10-05 13:38:13.391669Z] Finished create-virtualenv step (success) 06:38:13 INFO - [mozharness: 2016-10-05 13:38:13.392135Z] Running install step. 06:38:13 INFO - Running pre-action listener: _resource_record_pre_action 06:38:13 INFO - Running main action method: install 06:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:13 INFO - Reading from file tmpfile_stdout 06:38:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:13 INFO - Reading from file tmpfile_stdout 06:38:13 INFO - Output received: 06:38:13 INFO - Usage: mozinstall [options] installer 06:38:13 INFO - Options: 06:38:13 INFO - -h, --help show this help message and exit 06:38:13 INFO - -d DEST, --destination=DEST 06:38:13 INFO - Directory to install application into. [default: 06:38:13 INFO - "/builds/slave/test"] 06:38:13 INFO - --app=APP Application being installed. [default: firefox] 06:38:13 INFO - mkdir: /builds/slave/test/build/application 06:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:38:30 INFO - Reading from file tmpfile_stdout 06:38:30 INFO - Output received: 06:38:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:38:30 INFO - Running post-action listener: _resource_record_post_action 06:38:30 INFO - [mozharness: 2016-10-05 13:38:30.713842Z] Finished install step (success) 06:38:30 INFO - [mozharness: 2016-10-05 13:38:30.714090Z] Running run-tests step. 06:38:30 INFO - Running pre-action listener: _resource_record_pre_action 06:38:30 INFO - Running main action method: run_tests 06:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:30 INFO - Python 2.7.3 06:38:30 INFO - Return code: 0 06:38:30 INFO - grabbing minidump binary from tooltool 06:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf95690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf95b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:38:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:38:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:38:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:30 INFO - Return code: 0 06:38:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:38:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:38:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:38:30 INFO - Using env: {'DISPLAY': ':0', 06:38:30 INFO - 'HOME': '/home/cltbld', 06:38:30 INFO - 'LANG': 'en_US.UTF-8', 06:38:30 INFO - 'LANGUAGE': 'en_US:en', 06:38:30 INFO - 'LOGNAME': 'cltbld', 06:38:30 INFO - 'MAIL': '/var/mail/cltbld', 06:38:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:30 INFO - 'MOZ_NO_REMOTE': '1', 06:38:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:30 INFO - 'NO_EM_RESTART': '1', 06:38:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:30 INFO - 'PWD': '/builds/slave/test', 06:38:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:30 INFO - 'SHELL': '/bin/bash', 06:38:30 INFO - 'SHLVL': '1', 06:38:30 INFO - 'TERM': 'linux', 06:38:30 INFO - 'TMOUT': '86400', 06:38:30 INFO - 'USER': 'cltbld', 06:38:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235', 06:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:30 INFO - '_': '/tools/buildbot/bin/python'} 06:38:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:38:30 INFO - mozversion application_buildid: 20161005033001 06:38:30 INFO - mozversion application_changeset: c4a811b0531e3bf4279a1e19a3e4451f2e416719 06:38:30 INFO - mozversion application_display_name: Nightly 06:38:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:30 INFO - mozversion application_name: Firefox 06:38:30 INFO - mozversion application_remotingname: firefox 06:38:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:38:30 INFO - mozversion application_vendor: Mozilla 06:38:30 INFO - mozversion application_version: 52.0a1 06:38:30 INFO - mozversion platform_buildid: 20161005033001 06:38:30 INFO - mozversion platform_changeset: c4a811b0531e3bf4279a1e19a3e4451f2e416719 06:38:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:38:30 INFO - mozversion platform_version: 52.0a1 06:38:30 INFO - using testdate: 1475674710 06:38:30 INFO - actual date: 1475674710 06:38:30 INFO - starting webserver on 'localhost:47912' 06:38:30 INFO - SUITE-START | Running 2 tests 06:38:30 INFO - TEST-START | dromaeo_css 06:38:30 INFO - operating with platform_type : linux_ 06:38:30 INFO - Initialising browser for dromaeo_css test... 06:38:31 INFO - TEST-INFO | started process 16052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJVzVZG/profile http://localhost:47912/getInfo.html) 06:38:35 INFO - PROCESS | 16052 | __metrics Screen width/height:1600/1200 06:38:35 INFO - PROCESS | 16052 | colorDepth:24 06:38:35 INFO - PROCESS | 16052 | Browser inner width/height: 1024/697 06:38:35 INFO - PROCESS | 16052 | __metrics 06:38:36 INFO - PROCESS | 16052 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:38:36 INFO - PROCESS | 16052 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:36 INFO - PROCESS | 16052 | console.error: PushService: 06:38:36 INFO - PROCESS | 16052 | stateChangeProcessEnqueue: Error transitioning state 06:38:36 INFO - PROCESS | 16052 | UnknownError 06:38:37 INFO - TEST-INFO | 16052: exit 0 06:38:37 INFO - Browser initialized. 06:38:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:37 INFO - TEST-INFO | started process 16135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJVzVZG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:49 INFO - PROCESS | 16135 | RSS: Main: 174321664 06:38:49 INFO - PROCESS | 16135 | 06:39:40 INFO - PROCESS | 16135 | 1475674780863 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:41:52 INFO - PROCESS | 16135 | Cycle 1(1): loaded http://localhost:47912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47912/tests/dromaeo/cssquery-ext.html) 06:41:53 INFO - PROCESS | 16135 | RSS: Main: 294723584 06:41:53 INFO - PROCESS | 16135 | 06:44:55 INFO - PROCESS | 16135 | Cycle 1(1): loaded http://localhost:47912/tests/dromaeo/cssquery-ext.html (next: http://localhost:47912/tests/dromaeo/cssquery-jquery.html) 06:44:56 INFO - PROCESS | 16135 | RSS: Main: 280506368 06:44:56 INFO - PROCESS | 16135 | 06:47:58 INFO - PROCESS | 16135 | Cycle 1(1): loaded http://localhost:47912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47912/tests/dromaeo/cssquery-mootools.html) 06:47:59 INFO - PROCESS | 16135 | RSS: Main: 220426240 06:47:59 INFO - PROCESS | 16135 | 06:51:01 INFO - PROCESS | 16135 | Cycle 1(1): loaded http://localhost:47912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47912/tests/dromaeo/cssquery-prototype.html) 06:51:01 INFO - PROCESS | 16135 | RSS: Main: 279216128 06:51:01 INFO - PROCESS | 16135 | 06:54:04 INFO - PROCESS | 16135 | Cycle 1(1): loaded http://localhost:47912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47912/tests/dromaeo/cssquery-yui.html) 06:54:05 INFO - PROCESS | 16135 | RSS: Main: 222834688 06:54:05 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | Cycle 1(1): loaded http://localhost:47912/tests/dromaeo/cssquery-yui.html (next: http://localhost:47912/tests/dromaeo/cssquery-dojo.html) 06:57:08 INFO - PROCESS | 16135 | RSS: Main: 310444032 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | __start_tp_report 06:57:08 INFO - PROCESS | 16135 | _x_x_mozilla_page_load 06:57:08 INFO - PROCESS | 16135 | _x_x_mozilla_page_load_details 06:57:08 INFO - PROCESS | 16135 | |i|pagename|runs| 06:57:08 INFO - PROCESS | 16135 | |0;dojo.html;3004.7896647234693;3045.3452507710854;3054.6792586778392;3081.784275100744;3100.6589275179726;5099.260607211952;5202.0376230397405;5253.658512196705;5329.733513324333;5340.599455040878;5128.846134615958;5157.845264642057;5232.424433312332;5257.86855328617;5270.578353731692;4803.087413391444;4831.589314908237;4847.757612119398;4860.708357498544;4905.2642103684375;4908.8281910133155;4941.876453088666;4948.975255123737;4956.2070068789;4981.153203955337;4684.110019096361;4751.216049351853;4751.738654374008;4839.395075615548;4839.951600483985;4787.928181077286;4802.783874725646;4803.663743537953;4805;4809.9038019239415;4762.333273341735;4763.095011947719;4763.571278584944;4771.1173432914675;4779.020300838354;5168.198929165986;5215.530602245816;5217.087009773274;5218.921716174261;5232.398274198478;5550.139728342114;5585.441455854423;5624.634398764068;5635.49280564747;5640.520555752766;5547.223388725542;5561.63849349791;5676.035074037382;5696.829095127153;5704.372519022904;5219.451957544441;5259.921101183485;5271.973640131851;5272.657277276965;5276.419593844674;5519.31008623922;5750.88498230033;5764.827055188351;5773.797917072882;5850.531957443394;5337.146056630921;5414.566834653218;5505.311836020497;5505.476979687003;5508.669479831223;5571.220029195916;5584.246126772915;5598.356189038232;5599.972000140055;5601.579881508903;5562.443755624486;5570.944290557123;5583.162525621189;5583.944160558423;5643.125315576092;5394.91907621386;5463.31708536433;5516.586256030814;5598;5598.944010559923;4373.781310934441;4378.387025816324;4380.16776812411;4423.867283981485;4427.335899615019;3875.302445559826;3910.3743401055694;3934.567197608261;3947.842086316515;3948.6446219840354;5057.367829021372;5100.719460429637;5101.0308041472;5229.633925625246;5360.8659783504945;5479.6164268500825;5599.412061733459;5599.7480113394995;5612.438756124437;5612.522935550524;5274.630775845731;5284.947150528523;5298.072837253465;5331.147016477423;5349.759260833272;4786.210275304606;4838.346823178897;4847.127517046965;4852.781624826821;4888.682235654671;5600.663960162403;5607.663540187602;5675.517581005661;5750.827475175752;5764.971175144181;5526.060569703241;5541.141123125761;5560.666360018412;5625.88748225025;5631.2960879890015;5649.802256920988;5697.886042279214;5710.5146062585145;5714.314282286152;5717.285339332583;5374.973125134506;5391.568674506108;5439.5920305976415;5439.700816455133;5448.264484294569;5539.169124631338;5599.1041433370465;5600.831975040755;5616.410276921028;5679.943200567942;5337.412884582615;5352.384475785178;5361.678299302054;5363.946360536344;5367.731613419235;5222.738863056756;5382.434844341287;5390.110631745718;5392.5416339611575;5448.700321482356;5300.946990530046;5332.22682710997;5345.305110335631;5357.973210133924;5414.7021913795115;5328.786848526171;5360.115580929259;5371.892562148813;5378.435264297349;5380.354357477127;5176.7152806596;5239.659422137549;5256.342957130359;5258.290130832289;5310.336207974004 06:57:08 INFO - PROCESS | 16135 | |1;ext.html;544.8283790605959;554.8890221955608;555.4417810100847;556.9665820050798;567.9918145292108;28406.573901391497;29000.274993125182;35493.64506354939;36563.45154822673;36695.449568256496;36927.63072369275;37298.06754831131;37539.81230093852;37564.81217593915;37651.24697506048;8494.405391622573;8626.094260102693;8637.39538232324;8638.09300023498;8647.092055334193;7906.130325664172;8129.390295727814;8500.957495212515;9996.150327222194;10294.227932905025;10379.48102594871;10415.218858585637;10463.947680261588;10467.4766261687;10476.371417714961;10280.280380373377;10314.948425257826;10335.379877207353;10415.375077495375;10420;7619;7876.763697089096;9727.708168754878;10058.59765609382;10088.596456141746;32518;32858.34283314344;32902;32934.83532582322;32937.6706232937;2893.450244453547;3063.1576316512915;3086.845657717105;3110.440120778259;3292.407366673998;27459.725402745917;27797.722022779715;27838.3040423989;28359.149225523266;29132.70867291321;4184.225918205111;4231.576842315774;4345.217860785057;4411.404460397869;4442.911141777146;318398;318712;319110;319484;319991;41646;41911.37132943008;41973.160536789095;42090;42229.15541689211;47163;47195.864537609894;47201.29198062032;47227;47297.52702473;12530.624081277576;13012.21926684402;13085.607431777062;13094.083414161109;13137.211767293993;8958.462492250486;10277.331973421704;10461.163106951426;10483.266171368083;10488.790224195473;12012.939935300443;12679.429425675868;13036.869631303754;13052.21686698801;13431.462741490426;5429.511343979061;5458.645188062763;5462.508374246337;5578.888422231614;5613.438656134354;838.5974732128491;896.6278994217457;930.4370855632245;931.2177770672668;946.3470205558143;26573.734262657512;27495.725042749717;27624;27700.476473793733;27722.5841612376;945;945.4185675809327;987.5309228116587;1012.4330374989881;1027.111548510533;14317.427302907976;14508.763666113166;14574.489892853699;14689.92655036718;14757.631059223606;141258.2937085308;142159;143067.2846635781;143715;144333;46109;46153.307700384525;46185;46238.768806156426;46261;1095.7260684828634;1109.0351394287022;1127.4081107418506;1138.163449864349;1145.9656210313703;26049.6092558608;27389.589156162274;27551.586726199523;28127;28291.575626366033;40616.593834061285;40994.79502602468;41011.384829228184;41022.179556409304;41041.1791764169;420095;421975;422532;423097;423293;26314.21057368282;28428;29097.272568185967;33025.55078412131;33650.66349336573;35234.29531409306;38503;38664.6133538661;38731;38793.80603096967;32851.67148328486;33274.833625831714;33332.16669583183;33462;33537.329253415286;32583.674163258063;32630.51054234236;33253.83373083216;33510;34074.829625851715;33186.33627327488;33900.152496187795;33985.830070850476;34060.14849628779;34417.13957151091;29126.56310155307;30132.24669383283;30781.538276925417;30806;30849.383012340077;24507.632385513876;24634.384140396633;24671.876640616683;24701.50596988014;24752.25743227706 06:57:08 INFO - PROCESS | 16135 | |2;jquery.html;376.7099333513195;377.5529416428013;385.26799081744684;397.47334781414617;399.48067512234087;15534.22328883557;17580.64838703225;17725.82274177258;17836.55408614785;17884.016379099143;15232.238388080606;15572.922135389335;15944.840551594481;16150.596235094128;16564.503064908044;5390.1914712793105;5632.746526406301;5639.210510528529;5645.040343141676;5647.1529270609535;4017.337139372;4142.109446469009;4215.093754842708;4267.573242675739;5497.862553436176;6132;6165.445109940105;6273.5922165059355;6277.340879207686;6277.874442511147;5477.3427188737205;5753.367129615739;5782.3350314713925;6251;6253.1245625612455;5625.437456254383;5674.914876276859;5676.801311954103;5683.8010669626365;5685.772569097231;13506.729865402735;17066.658666826595;19545;20717.928207179313;20894.164233430645;2174.565086982594;2313.8958746856433;2480.7891329237036;2602.7267136950536;2770.875310611007;9537.618495260182;9613.327067105236;10057.195424366033;10063.496825158785;12847.807282890764;1812.4109664359137;1822.7448157257995;1843.0324079858183;1866.2628261836498;1887.4903775980408;74564;76455;78042.60978695127;81167.5941620294;83309.16690833075;10287.691369258935;10488.68533943983;10602;10790.568377264979;10806.837897431546;14444;14447.85552144486;14472.710545789025;14473.493427729978;14503.347349369304;6927.134108236471;7143.678534465961;7160.711072007089;7305.4886157969495;7373.446991475661;6669.233038200572;6700.296468870796;6795.864082718318;6848.212455567574;6943.930560694429;4322.632576231055;4454.621357184611;4471.28459446487;4567.931481027787;4607.308903664477;1842.2907180735513;1844.2069909938587;1884.1050501012185;1893;1915.243478825856;738.3354980517577;806.9193080692002;825.9917400826035;854.6581367453068;886.3751055505853;16578.75131873023;16697.582560435843;17320.480385588453;17629.118544072746;17767.555811104827;853.5220276645099;857.7383897911197;862.5342315149749;885.8715486254457;923.9076092390842;9226.90773092274;9402.34183607141;9469.147776699992;9578.664746733832;9711.951440242754;419897;427617;444757;444872;447212;85304;85527;91117.61029871267;91237;92269;861.7242482405695;872.3544577012965;899.3569597737518;918.3250311021394;918.7060140754894;15350.539483815503;15618.687626247638;15706.528804135894;15730.528084157493;16210.432634857723;36980.63019369772;37015.70445034411;39130.41304380493;39480;41530;46605.095605065566;49172;51658.48341516537;53367.4663253378;54605.45394546004;7811.687532498637;7927.5243485391065;7969.960150199212;8245.505269683837;8301.128381520095;11282.661520154408;12217.816732749194;12264.141510094209;12497.750044998867;12938.870611294144;10925.617603383844;11041.834372484258;11210.831837522606;11316.886831131913;11458.885411145782;10097.545610447694;10145.89854101479;10170.389776613427;10460.738481538023;10623.203259755395;9816.852747208655;10849.837252441377;10991.450427478754;11372.488238029144;11772.470238839443;8045.436819422584;8092.757217283491;8382.706605268786;8390.748277551684;8427.367947403847;9782.309864787241;11288.153388495732;11556.711082223012;11738.237014594024;11889.821652675044 06:57:08 INFO - PROCESS | 16135 | |3;mootools.html;1104.7017305327556;1176.705823544114;1192.701824543864;1244.4648801015562;1396.3437184523277;7450.217727138654;8344.207300306469;8673.69642062528;8699.304055675546;8908.020117787039;8725.869111963326;8730.60712267948;8796.428232164904;8798.736037918872;8813.4711917285;2294.8508346957437;2319.118734880751;2323.7327707313707;2326.7789559991775;2333.708286464192;2270.886455677218;2297.8046866016407;2343;2347.096367898363;2348.6711860339565;2262.4570103175283;2296.47181148336;2296.5406918616345;2323.8605683659034;2326.9069237230574;2265.1166045242367;2273.7498875123724;2282.2354511238755;2283.748787633359;2283.931482055541;2225.7329120505483;2245.023414814561;2249.640057590794;2254.7745225477483;2264.62633665445;8648.30813534922;8659.48043117415;8693.782655433664;8777.605007774666;8807.64769409223;5122.974385128088;5249.553787928031;5253.343332083489;5261.1319132343115;5266.315379000744;3185.681431856819;3352.4636058230567;3400;3418.3163367326633;3460.8269586520573;1213.071999920062;1218.585680868509;1222.2299951030882;1249.775040492711;1251.3367915004972;12979.091463597646;12979.41592628334;13004.804927926089;13019.739605207842;13093.47626094955;4199.013231890503;4311.6335111515245;4398.142362239332;4435.756033418128;4561.429821272341;9559.90440095604;9567.521623918776;9579.760505987406;9581;9581.856272155923;5141.048905952411;5157.716325602053;5159.045576568272;5161.174212126042;5163.612729045261;4089.734167279117;4217.451731274915;4604.976975115103;4724.598409135262;4829.5653391194255;3590.8922732318074;3673.632636736305;3711.402018586946;3735.402335626287;3742.8128593570214;1137.4824454873178;1149.5458245319678;1151.153901882116;1163.4182908545727;1173.7359094203907;733.8789099798473;790.9835860918691;838.2288294768828;841.1966571923798;844.2233145506149;5662.546996240291;5684.744186511617;5697.430256974352;5704.429557044263;5914.4381283777975;425.84882366759973;431.42189466115553;431.5188564750281;886.7339798060556;909.9208309013871;3610.6750392464805;3918.2359439908946;3983.6016398359934;3991.201759648082;3998.6001399859783;10889.673309800719;10943.343399396063;11136.443177841076;11162.051225645748;11168.497417616065;11014.284071535325;11126.721831954266;11158.944205278922;11176.161787865942;11210.495527701272;8138.348932085419;8321.542315172723;8345.54099524532;8352.290055345242;8353.081161072278;5795.710214489174;5841.737121829613;5868.67722275279;5989.431004054608;6073.817785466443;10183.18534517222;10520.631777887736;10609.575616975235;10616.522256498321;10720.571177153139;10853.240273180802;10864.891351086388;10870.45647717595;10891.891081089088;10894.67315980522;6907.205671347659;7110.4667149962925;7272.127344718668;7695.345895598937;7852.6073696313815;8237.546934918637;8548.23065924045;8587.184217499327;8640.956795215983;8662;7629.504082234637;7664.616769161631;7761.805954850948;7826.373890088893;7944.761657150295;7340.743073992385;7462.813429664302;7483.139438964588;7503.812404689927;7726.227377262228;6830.282820303796;6927.58434493932;6933.7226510939;6937.098177236927;6941.167059952636;4758.595519380753;4846.684965477232;4848.878778030577;4922.975385123052;4978.576820970258;4861.638741152483;4873.195922672861;4898.142825005539;4975.129352363249;5094.057599344133 06:57:08 INFO - PROCESS | 16135 | |4;prototype.html;299.57460406223174;310.36840030537854;319.11604854552905;319.59251953758957;322.8627833170903;4784.83253086142;5077.289179514871;5237.921431178531;5281.313429254196;5281.630285879985;5116.258142569325;5182.481751824816;5198.3761948566225;5215.973920130394;5220.29526013988;4129.132882094764;4132.982922466601;4134.64855487284;4138.461999940004;4140.648044916194;3918.5689574146822;4148.585141485857;4150.588799808064;4156.5012198536215;4159.355299928516;3793.180854513254;4036.596340365955;4040.1111755413763;4060.7563546187175;4084.530279017921;4045.2314060328736;4052.2705912935808;4055;4066.7356621819486;4067.0239142605856;3590.120420496969;3592.46113083037;3593.3711600469815;3593.9820300898327;3606.891793246207;4896.4858689837765;5011.624128190364;5044.344235249431;5051.696898186084;5097.5667068299235;4576.588107070346;4586.564276393738;4592.47186573545;4593.494715581283;4594.862154135381;5389.164679474688;5413.431589683066;5419.647722897999;5440.91838622421;5446.618736688433;3759.586445490994;3830.5403351597706;3846.903827404309;3862.903427414309;3904.7657140571655;5368.926214757064;5546.362168350692;5605.691686957216;5605.80379686709;5607.495325420732;3776.962230377716;3916.373380259145;3924.529056513237;3924.95988563031;3927.0378757204667;3955;3962.9101996951067;3963.6630886374983;3974.205158968218;3974.82113304902;4545.2954792007295;4546.0680560485025;4553.681242313072;4564.338170965191;4565.338025986213;5259.395169555473;5429.67421954684;5438.91841622376;5459.689674478176;5463.808766693147;1325.1651459580403;1338.6921008168176;1341.4298922957898;1342.5435351980373;1346.2393747532808;832.9167083291622;872.9388942773945;880.3229847141206;882.7925437522177;885.1679421343916;4709.3877795887;4711.149754398608;4720.291956206596;4728.243481043085;4733.053389322149;4878.682885612424;4906.435759887659;4919.87700307488;4922.360093187863;4922.556969872729;4434.84478043267;4701.918558731442;4721.787519561628;4757.643176761757;4761.47623761386;2630.3954587701487;2632;2640.194740604134;2649.7482739140137;2657.521646103681;5107.821226257138;5125.64120511568;5129.076596276396;5140.3831540215415;5147.536721695065;4861.708297502161;5068.288465670848;5077.461269365317;5081.644284900021;5087.26234695967;5109.824740309749;5118.310957384128;5121.28302037715;5121.743912804271;5122.282880396748;4873.805047798049;4886.849786094107;4922.290143433743;4941.802327906844;4946.307516947558;4560.361549383156;4834.854954351375;4861.51384861511;4866.221404575251;4893.657443979029;4938.38270216223;5010.273510341053;5463.453654634504;5602.982926146503;5655.7454914528125;3985.5815139409942;3987.282289187858;3993.740406873544;3995.780232087263;4006.659433948147;5626.212330273846;5626.803061892814;5627.465390787868;5635.718214089361;5645.661260324394;5141.38303403594;5277.733343997336;5314.415414304346;5329.493698098674;5352.384475785335;5278.89442211146;5285.207218917193;5286.171898034687;5309.973450132725;5324.988252232063;5381.865453363697;5413.431589683184;5417.945820541744;5426.182228953345;5439.912017596417;5164.7417629119145;5382.623216374816;5444.074507333684;5453.563714902719;5454.59090568201;5287.629865909349;5289.788408463773;5296.9670914171365;5307.6465501296925;5308.097623404108 06:57:08 INFO - PROCESS | 16135 | |5;yui.html;597.2415032908207;599.9010163323052;629.6395140803997;652.2694582068084;670.996645016775;12980.156289841178;13504.662383440407;14046.929765351158;14055.859441405582;14086.225257610828;12287.877121228785;12319.384030798468;12377.071719621043;12432.378381080955;12486.750264994695;573.6070791507809;584.0888214385551;584.8976429124907;585.0463744097116;585.8769658371747;501.0255053920127;511.93600799900014;512.1651707716417;512.8487096306579;575.4130786597668;591.6745789815606;606.9666168360739;608.367298010069;610.560396514511;612.2347066167291;601.2334273800917;602.01570432343;602.1209034809184;603.0923460192404;603.2158194347331;383.8253594614472;437.7986126381868;438.00572699971207;438.29653406282773;438.46507261141676;10175.185985121172;10605.31065480749;10617;11072;11763.764724705457;13408.932955335258;13711.657208569766;13901.930490347484;14073;14163.291835408292;11356.375399353032;11403.429828508624;11466.369349685847;11674.708132296675;11741.765164696659;3766.1714422826935;3791.109089363997;3796.0509872531866;3810.90472738181;3974.920501589952;75542.62228688876;76852.61573692095;77598.6120069396;78888.21111788866;80937.59531202307;10359.223058270509;10385.273030887916;10477;10520.421376824195;10652;19265.51836204106;19304.420867374;19339.419817405218;19341.226350946086;19349.322773702854;6954.200266969262;7015;7612.391008719289;7876.763697089096;8044.557549334842;4327.069680018811;4413.337999300131;4431.446069241345;4570.343943474463;4636.142313671981;3255.5116732490314;3359.0930448778695;3379.374815659111;3379.797212167278;3383.9323213536086;554.4289381936612;555.303094616254;567.2059117235821;573.3778849947853;575.7840809696364;521.9504147106019;560.7224423910191;561.1806762127339;569.4135040907871;609.9664518451439;8445.259355325907;8807.251383632334;8825.955870220609;9141;9159.90840091604;500.44200716201175;530.6921985248547;533.8265063854263;555.1506195520859;581.1805354450205;3860.9227815444096;3906.570277269498;4183.184279065614;4194.832206711759;4237.703360764717;109223;110999.44500277448;112973.43513282546;116514;116535;99070;99332.50333748285;99638;99822;101837.49081254547;91193.99999999868;91872.54063729772;92415.53792230996;92582.53708731548;93835.17131744947;7737.381009519112;7811.257930496594;7830.41271904598;7866.7639970800965;8158.143394943446;50128;50446.74776626093;52181.47818521766;52199.73900130475;52234.73882630715;72556.6372168157;75370;76379.66230278925;77728.61135694286;79093;9512.762180945532;9811.116999470081;9884.159846413135;9937.10566049059;10149.23880708935;12108.091893107876;12152.878471215528;12489.18820276679;12694;13266.602001939957;10941.890581094405;10971.945140274247;11121.888781112086;11206.719832004264;11609.419529023684;11428.485718142538;11520.94239528797;11567.363794991019;12000.699982500508;12456.252624842538;10199.592016319264;10686.73283167927;10766;10766;11092.889071109186;9111.225545828678;9378.062193780568;9440.575174117319;9807.411555306704;10020.69937901864;8859.424137431046;9366.203872670627;9580.281478888972;9665.323427360017;9692.903070969482 06:57:08 INFO - PROCESS | 16135 | __end_tp_report 06:57:08 INFO - PROCESS | 16135 | __start_cc_report 06:57:08 INFO - PROCESS | 16135 | _x_x_mozilla_cycle_collect,1097 06:57:08 INFO - PROCESS | 16135 | __end_cc_report 06:57:08 INFO - PROCESS | 16135 | __startTimestamp1475675828435__endTimestamp 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | ------- Summary: start ------- 06:57:08 INFO - PROCESS | 16135 | Number of tests: 6 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | [#0] dojo.html Cycles:165 Average:5185.93 Median:5337.41 stddev:552.05 (10.3%) stddev-sans-first:526.56 06:57:08 INFO - PROCESS | 16135 | Values: 3004.8 3045.3 3054.7 3081.8 3100.7 5099.3 5202.0 5253.7 5329.7 5340.6 5128.8 5157.8 5232.4 5257.9 5270.6 4803.1 4831.6 4847.8 4860.7 4905.3 4908.8 4941.9 4949.0 4956.2 4981.2 4684.1 4751.2 4751.7 4839.4 4840.0 4787.9 4802.8 4803.7 4805.0 4809.9 4762.3 4763.1 4763.6 4771.1 4779.0 5168.2 5215.5 5217.1 5218.9 5232.4 5550.1 5585.4 5624.6 5635.5 5640.5 5547.2 5561.6 5676.0 5696.8 5704.4 5219.5 5259.9 5272.0 5272.7 5276.4 5519.3 5750.9 5764.8 5773.8 5850.5 5337.1 5414.6 5505.3 5505.5 5508.7 5571.2 5584.2 5598.4 5600.0 5601.6 5562.4 5570.9 5583.2 5583.9 5643.1 5394.9 5463.3 5516.6 5598.0 5598.9 4373.8 4378.4 4380.2 4423.9 4427.3 3875.3 3910.4 3934.6 3947.8 3948.6 5057.4 5100.7 5101.0 5229.6 5360.9 5479.6 5599.4 5599.7 5612.4 5612.5 5274.6 5284.9 5298.1 5331.1 5349.8 4786.2 4838.3 4847.1 4852.8 4888.7 5600.7 5607.7 5675.5 5750.8 5765.0 5526.1 5541.1 5560.7 5625.9 5631.3 5649.8 5697.9 5710.5 5714.3 5717.3 5375.0 5391.6 5439.6 5439.7 5448.3 5539.2 5599.1 5600.8 5616.4 5679.9 5337.4 5352.4 5361.7 5363.9 5367.7 5222.7 5382.4 5390.1 5392.5 5448.7 5300.9 5332.2 5345.3 5358.0 5414.7 5328.8 5360.1 5371.9 5378.4 5380.4 5176.7 5239.7 5256.3 5258.3 5310.3 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | [#1] ext.html Cycles:180 Average:44027.33 Median:32936.25 stddev:84041.24 (255.2%) stddev-sans-first:84213.59 06:57:08 INFO - PROCESS | 16135 | Values: 544.8 554.9 555.4 557.0 568.0 28406.6 29000.3 35493.6 36563.5 36695.4 36927.6 37298.1 37539.8 37564.8 37651.2 8494.4 8626.1 8637.4 8638.1 8647.1 7906.1 8129.4 8501.0 9996.2 10294.2 10379.5 10415.2 10463.9 10467.5 10476.4 10280.3 10314.9 10335.4 10415.4 10420.0 7619.0 7876.8 9727.7 10058.6 10088.6 32518.0 32858.3 32902.0 32934.8 32937.7 2893.5 3063.2 3086.8 3110.4 3292.4 27459.7 27797.7 27838.3 28359.1 29132.7 4184.2 4231.6 4345.2 4411.4 4442.9 318398.0 318712.0 319110.0 319484.0 319991.0 41646.0 41911.4 41973.2 42090.0 42229.2 47163.0 47195.9 47201.3 47227.0 47297.5 12530.6 13012.2 13085.6 13094.1 13137.2 8958.5 10277.3 10461.2 10483.3 10488.8 12012.9 12679.4 13036.9 13052.2 13431.5 5429.5 5458.6 5462.5 5578.9 5613.4 838.6 896.6 930.4 931.2 946.3 26573.7 27495.7 27624.0 27700.5 27722.6 945.0 945.4 987.5 1012.4 1027.1 14317.4 14508.8 14574.5 14689.9 14757.6 141258.3 142159.0 143067.3 143715.0 144333.0 46109.0 46153.3 46185.0 46238.8 46261.0 1095.7 1109.0 1127.4 1138.2 1146.0 26049.6 27389.6 27551.6 28127.0 28291.6 40616.6 40994.8 41011.4 41022.2 41041.2 420095.0 421975.0 422532.0 423097.0 423293.0 26314.2 28428.0 29097.3 33025.6 33650.7 35234.3 38503.0 38664.6 38731.0 38793.8 32851.7 33274.8 33332.2 33462.0 33537.3 32583.7 32630.5 33253.8 33510.0 34074.8 33186.3 33900.2 33985.8 34060.1 34417.1 29126.6 30132.2 30781.5 30806.0 30849.4 24507.6 24634.4 24671.9 24701.5 24752.3 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | [#2] jquery.html Cycles:180 Average:26436.80 Median:215942.29 stddev:72295.15 (33.5%) stddev-sans-first:72471.48 06:57:08 INFO - PROCESS | 16135 | Values: 376.7 377.6 385.3 397.5 399.5 15534.2 17580.6 17725.8 17836.6 17884.0 15232.2 15572.9 15944.8 16150.6 16564.5 5390.2 5632.7 5639.2 5645.0 5647.2 4017.3 4142.1 4215.1 4267.6 5497.9 6132.0 6165.4 6273.6 6277.3 6277.9 5477.3 5753.4 5782.3 6251.0 6253.1 5625.4 5674.9 5676.8 5683.8 5685.8 13506.7 17066.7 19545.0 20717.9 20894.2 2174.6 2313.9 2480.8 2602.7 2770.9 9537.6 9613.3 10057.2 10063.5 12847.8 1812.4 1822.7 1843.0 1866.3 1887.5 74564.0 76455.0 78042.6 81167.6 83309.2 10287.7 10488.7 10602.0 10790.6 10806.8 14444.0 14447.9 14472.7 14473.5 14503.3 6927.1 7143.7 7160.7 7305.5 7373.4 6669.2 6700.3 6795.9 6848.2 6943.9 4322.6 4454.6 4471.3 4567.9 4607.3 1842.3 1844.2 1884.1 1893.0 1915.2 738.3 806.9 826.0 854.7 886.4 16578.8 16697.6 17320.5 17629.1 17767.6 853.5 857.7 862.5 885.9 923.9 9226.9 9402.3 9469.1 9578.7 9712.0 419897.0 427617.0 444757.0 444872.0 447212.0 85304.0 85527.0 91117.6 91237.0 92269.0 861.7 872.4 899.4 918.3 918.7 15350.5 15618.7 15706.5 15730.5 16210.4 36980.6 37015.7 39130.4 39480.0 41530.0 46605.1 49172.0 51658.5 53367.5 54605.5 7811.7 7927.5 7970.0 8245.5 8301.1 11282.7 12217.8 12264.1 12497.8 12938.9 10925.6 11041.8 11210.8 11316.9 11458.9 10097.5 10145.9 10170.4 10460.7 10623.2 9816.9 10849.8 10991.5 11372.5 11772.5 8045.4 8092.8 8382.7 8390.7 8427.4 9782.3 11288.2 11556.7 11738.2 11889.8 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | [#3] mootools.html Cycles:180 Average:5740.65 Median:4664.79 stddev:3410.12 (73.1%) stddev-sans-first:3401.89 06:57:08 INFO - PROCESS | 16135 | Values: 1104.7 1176.7 1192.7 1244.5 1396.3 7450.2 8344.2 8673.7 8699.3 8908.0 8725.9 8730.6 8796.4 8798.7 8813.5 2294.9 2319.1 2323.7 2326.8 2333.7 2270.9 2297.8 2343.0 2347.1 2348.7 2262.5 2296.5 2296.5 2323.9 2326.9 2265.1 2273.7 2282.2 2283.7 2283.9 2225.7 2245.0 2249.6 2254.8 2264.6 8648.3 8659.5 8693.8 8777.6 8807.6 5123.0 5249.6 5253.3 5261.1 5266.3 3185.7 3352.5 3400.0 3418.3 3460.8 1213.1 1218.6 1222.2 1249.8 1251.3 12979.1 12979.4 13004.8 13019.7 13093.5 4199.0 4311.6 4398.1 4435.8 4561.4 9559.9 9567.5 9579.8 9581.0 9581.9 5141.0 5157.7 5159.0 5161.2 5163.6 4089.7 4217.5 4605.0 4724.6 4829.6 3590.9 3673.6 3711.4 3735.4 3742.8 1137.5 1149.5 1151.2 1163.4 1173.7 733.9 791.0 838.2 841.2 844.2 5662.5 5684.7 5697.4 5704.4 5914.4 425.8 431.4 431.5 886.7 909.9 3610.7 3918.2 3983.6 3991.2 3998.6 10889.7 10943.3 11136.4 11162.1 11168.5 11014.3 11126.7 11158.9 11176.2 11210.5 8138.3 8321.5 8345.5 8352.3 8353.1 5795.7 5841.7 5868.7 5989.4 6073.8 10183.2 10520.6 10609.6 10616.5 10720.6 10853.2 10864.9 10870.5 10891.9 10894.7 6907.2 7110.5 7272.1 7695.3 7852.6 8237.5 8548.2 8587.2 8641.0 8662.0 7629.5 7664.6 7761.8 7826.4 7944.8 7340.7 7462.8 7483.1 7503.8 7726.2 6830.3 6927.6 6933.7 6937.1 6941.2 4758.6 4846.7 4848.9 4923.0 4978.6 4861.6 4873.2 4898.1 4975.1 5094.1 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | [#4] prototype.html Cycles:180 Average:4404.69 Median:4901.46 stddev:1271.90 (25.9%) stddev-sans-first:1237.59 06:57:08 INFO - PROCESS | 16135 | Values: 299.6 310.4 319.1 319.6 322.9 4784.8 5077.3 5237.9 5281.3 5281.6 5116.3 5182.5 5198.4 5216.0 5220.3 4129.1 4133.0 4134.6 4138.5 4140.6 3918.6 4148.6 4150.6 4156.5 4159.4 3793.2 4036.6 4040.1 4060.8 4084.5 4045.2 4052.3 4055.0 4066.7 4067.0 3590.1 3592.5 3593.4 3594.0 3606.9 4896.5 5011.6 5044.3 5051.7 5097.6 4576.6 4586.6 4592.5 4593.5 4594.9 5389.2 5413.4 5419.6 5440.9 5446.6 3759.6 3830.5 3846.9 3862.9 3904.8 5368.9 5546.4 5605.7 5605.8 5607.5 3777.0 3916.4 3924.5 3925.0 3927.0 3955.0 3962.9 3963.7 3974.2 3974.8 4545.3 4546.1 4553.7 4564.3 4565.3 5259.4 5429.7 5438.9 5459.7 5463.8 1325.2 1338.7 1341.4 1342.5 1346.2 832.9 872.9 880.3 882.8 885.2 4709.4 4711.1 4720.3 4728.2 4733.1 4878.7 4906.4 4919.9 4922.4 4922.6 4434.8 4701.9 4721.8 4757.6 4761.5 2630.4 2632.0 2640.2 2649.7 2657.5 5107.8 5125.6 5129.1 5140.4 5147.5 4861.7 5068.3 5077.5 5081.6 5087.3 5109.8 5118.3 5121.3 5121.7 5122.3 4873.8 4886.8 4922.3 4941.8 4946.3 4560.4 4834.9 4861.5 4866.2 4893.7 4938.4 5010.3 5463.5 5603.0 5655.7 3985.6 3987.3 3993.7 3995.8 4006.7 5626.2 5626.8 5627.5 5635.7 5645.7 5141.4 5277.7 5314.4 5329.5 5352.4 5278.9 5285.2 5286.2 5310.0 5325.0 5381.9 5413.4 5417.9 5426.2 5439.9 5164.7 5382.6 5444.1 5453.6 5454.6 5287.6 5289.8 5297.0 5307.6 5308.1 06:57:08 INFO - PROCESS | 16135 | 06:57:08 INFO - PROCESS | 16135 | [#5] yui.html Cycles:180 Average:20095.02 Median:50287.37 stddev:30685.41 (61.0%) stddev-sans-first:30736.57 06:57:08 INFO - PROCESS | 16135 | Values: 597.2 599.9 629.6 652.3 671.0 12980.2 13504.7 14046.9 14055.9 14086.2 12287.9 12319.4 12377.1 12432.4 12486.8 573.6 584.1 584.9 585.0 585.9 501.0 511.9 512.2 512.8 575.4 591.7 607.0 608.4 610.6 612.2 601.2 602.0 602.1 603.1 603.2 383.8 437.8 438.0 438.3 438.5 10175.2 10605.3 10617.0 11072.0 11763.8 13408.9 13711.7 13901.9 14073.0 14163.3 11356.4 11403.4 11466.4 11674.7 11741.8 3766.2 3791.1 3796.1 3810.9 3974.9 75542.6 76852.6 77598.6 78888.2 80937.6 10359.2 10385.3 10477.0 10520.4 10652.0 19265.5 19304.4 19339.4 19341.2 19349.3 6954.2 7015.0 7612.4 7876.8 8044.6 4327.1 4413.3 4431.4 4570.3 4636.1 3255.5 3359.1 3379.4 3379.8 3383.9 554.4 555.3 567.2 573.4 575.8 522.0 560.7 561.2 569.4 610.0 8445.3 8807.3 8826.0 9141.0 9159.9 500.4 530.7 533.8 555.2 581.2 3860.9 3906.6 4183.2 4194.8 4237.7 109223.0 110999.4 112973.4 116514.0 116535.0 99070.0 99332.5 99638.0 99822.0 101837.5 91194.0 91872.5 92415.5 92582.5 93835.2 7737.4 7811.3 7830.4 7866.8 8158.1 50128.0 50446.7 52181.5 52199.7 52234.7 72556.6 75370.0 76379.7 77728.6 79093.0 9512.8 9811.1 9884.2 9937.1 10149.2 12108.1 12152.9 12489.2 12694.0 13266.6 10941.9 10971.9 11121.9 11206.7 11609.4 11428.5 11520.9 11567.4 12000.7 12456.3 10199.6 10686.7 10766.0 10766.0 11092.9 9111.2 9378.1 9440.6 9807.4 10020.7 8859.4 9366.2 9580.3 9665.3 9692.9 06:57:08 INFO - PROCESS | 16135 | -------- Summary: end -------- 06:57:08 INFO - PROCESS | 16135 | 06:57:09 INFO - TEST-INFO | 16135: exit 0 06:57:09 INFO - TEST-OK | dromaeo_css | took 1118442ms 06:57:09 INFO - TEST-START | kraken 06:57:09 INFO - operating with platform_type : linux_ 06:57:09 INFO - Initialising browser for kraken test... 06:57:09 INFO - TEST-INFO | started process 16442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn8m2Rs/profile http://localhost:47912/getInfo.html) 06:57:13 INFO - PROCESS | 16442 | __metrics Screen width/height:1600/1200 06:57:13 INFO - PROCESS | 16442 | colorDepth:24 06:57:13 INFO - PROCESS | 16442 | Browser inner width/height: 1024/697 06:57:13 INFO - PROCESS | 16442 | __metrics 06:57:14 INFO - PROCESS | 16442 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:57:14 INFO - PROCESS | 16442 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:15 INFO - PROCESS | 16442 | console.error: PushService: 06:57:15 INFO - PROCESS | 16442 | stateChangeProcessEnqueue: Error transitioning state 06:57:15 INFO - PROCESS | 16442 | UnknownError 06:57:15 INFO - TEST-INFO | 16442: exit 0 06:57:15 INFO - Browser initialized. 06:57:15 INFO - Running cycle 1/1 for kraken test... 06:57:15 INFO - TEST-INFO | started process 16523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn8m2Rs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:27 INFO - PROCESS | 16523 | RSS: Main: 178233344 06:57:27 INFO - PROCESS | 16523 | 06:57:30 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47912/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:31 INFO - PROCESS | 16523 | RSS: Main: 237137920 06:57:31 INFO - PROCESS | 16523 | 06:57:33 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47912/tests/kraken/driver.html?testName=audio-dft) 06:57:34 INFO - PROCESS | 16523 | RSS: Main: 222093312 06:57:34 INFO - PROCESS | 16523 | 06:57:37 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47912/tests/kraken/driver.html?testName=audio-fft) 06:57:38 INFO - PROCESS | 16523 | RSS: Main: 304152576 06:57:38 INFO - PROCESS | 16523 | 06:57:40 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47912/tests/kraken/driver.html?testName=audio-oscillator) 06:57:40 INFO - PROCESS | 16523 | RSS: Main: 213213184 06:57:40 INFO - PROCESS | 16523 | 06:57:43 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:43 INFO - PROCESS | 16523 | RSS: Main: 217432064 06:57:43 INFO - PROCESS | 16523 | 06:57:46 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47912/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:47 INFO - PROCESS | 16523 | RSS: Main: 254406656 06:57:47 INFO - PROCESS | 16523 | 06:57:50 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47912/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:51 INFO - PROCESS | 16523 | RSS: Main: 253657088 06:57:51 INFO - PROCESS | 16523 | 06:57:53 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47912/tests/kraken/driver.html?testName=json-parse-financial) 06:57:54 INFO - PROCESS | 16523 | RSS: Main: 252764160 06:57:54 INFO - PROCESS | 16523 | 06:57:56 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:56 INFO - PROCESS | 16523 | RSS: Main: 214863872 06:57:56 INFO - PROCESS | 16523 | 06:57:58 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:59 INFO - PROCESS | 16523 | RSS: Main: 222142464 06:57:59 INFO - PROCESS | 16523 | 06:58:01 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:01 INFO - PROCESS | 16523 | RSS: Main: 228114432 06:58:01 INFO - PROCESS | 16523 | 06:58:04 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:05 INFO - PROCESS | 16523 | RSS: Main: 235810816 06:58:05 INFO - PROCESS | 16523 | 06:58:07 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:08 INFO - PROCESS | 16523 | RSS: Main: 234364928 06:58:08 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:47912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47912/tests/kraken/driver.html?testName=ai-astar) 06:58:10 INFO - PROCESS | 16523 | RSS: Main: 283262976 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | __start_tp_report 06:58:10 INFO - PROCESS | 16523 | _x_x_mozilla_page_load 06:58:10 INFO - PROCESS | 16523 | _x_x_mozilla_page_load_details 06:58:10 INFO - PROCESS | 16523 | |i|pagename|runs| 06:58:10 INFO - PROCESS | 16523 | |0;ai-astar;109;110;112;109;110;110;110;109;108;109 06:58:10 INFO - PROCESS | 16523 | |1;audio-beat-detection;151;123;128;171;124;123;124;123;152;122 06:58:10 INFO - PROCESS | 16523 | |2;audio-dft;161;162;161;161;159;162;160;163;161;164 06:58:10 INFO - PROCESS | 16523 | |3;audio-fft;76;77;76;122;76;77;76;77;108;77 06:58:10 INFO - PROCESS | 16523 | |4;audio-oscillator;83;82;112;82;83;83;113;82;82;110 06:58:10 INFO - PROCESS | 16523 | |5;imaging-gaussian-blur;117;116;116;117;116;117;116;117;116;117 06:58:10 INFO - PROCESS | 16523 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;145;146 06:58:10 INFO - PROCESS | 16523 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;96;96 06:58:10 INFO - PROCESS | 16523 | |8;json-parse-financial;51;49;50;50;51;52;52;52;52;50 06:58:10 INFO - PROCESS | 16523 | |9;json-stringify-tinderbox;61;62;61;62;61;63;61;62;62;63 06:58:10 INFO - PROCESS | 16523 | |10;stanford-crypto-aes;89;80;88;82;79;88;79;79;79;80 06:58:10 INFO - PROCESS | 16523 | |11;stanford-crypto-ccm;135;131;139;132;145;130;131;142;163;131 06:58:10 INFO - PROCESS | 16523 | |12;stanford-crypto-pbkdf2;165;168;168;167;173;169;167;167;169;167 06:58:10 INFO - PROCESS | 16523 | |13;stanford-crypto-sha256-iterative;66;65;65;71;64;65;64;65;64;64 06:58:10 INFO - PROCESS | 16523 | __end_tp_report 06:58:10 INFO - PROCESS | 16523 | __start_cc_report 06:58:10 INFO - PROCESS | 16523 | _x_x_mozilla_cycle_collect,1665 06:58:10 INFO - PROCESS | 16523 | __end_cc_report 06:58:10 INFO - PROCESS | 16523 | __startTimestamp1475675890370__endTimestamp 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | ------- Summary: start ------- 06:58:10 INFO - PROCESS | 16523 | Number of tests: 14 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.07 (1.0%) stddev-sans-first:1.12 06:58:10 INFO - PROCESS | 16523 | Values: 109.0 110.0 112.0 109.0 110.0 110.0 110.0 109.0 108.0 109.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:126.00 stddev:17.40 (13.8%) stddev-sans-first:17.35 06:58:10 INFO - PROCESS | 16523 | Values: 151.0 123.0 128.0 171.0 124.0 123.0 124.0 123.0 152.0 122.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 06:58:10 INFO - PROCESS | 16523 | Values: 161.0 162.0 161.0 161.0 159.0 162.0 160.0 163.0 161.0 164.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.50 stddev:16.57 (21.7%) stddev-sans-first:17.31 06:58:10 INFO - PROCESS | 16523 | Values: 76.0 77.0 76.0 122.0 76.0 77.0 76.0 77.0 108.0 77.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:14.15 (17.3%) stddev-sans-first:14.69 06:58:10 INFO - PROCESS | 16523 | Values: 83.0 82.0 112.0 82.0 83.0 83.0 113.0 82.0 82.0 110.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:58:10 INFO - PROCESS | 16523 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:58:10 INFO - PROCESS | 16523 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:58:10 INFO - PROCESS | 16523 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.50 stddev:1.10 (2.1%) stddev-sans-first:1.17 06:58:10 INFO - PROCESS | 16523 | Values: 51.0 49.0 50.0 50.0 51.0 52.0 52.0 52.0 52.0 50.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 06:58:10 INFO - PROCESS | 16523 | Values: 61.0 62.0 61.0 62.0 61.0 63.0 61.0 62.0 62.0 63.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:4.27 (5.3%) stddev-sans-first:3.78 06:58:10 INFO - PROCESS | 16523 | Values: 89.0 80.0 88.0 82.0 79.0 88.0 79.0 79.0 79.0 80.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:137.00 stddev:10.26 (7.5%) stddev-sans-first:10.83 06:58:10 INFO - PROCESS | 16523 | Values: 135.0 131.0 139.0 132.0 145.0 130.0 131.0 142.0 163.0 131.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.00 stddev:2.11 (1.3%) stddev-sans-first:1.94 06:58:10 INFO - PROCESS | 16523 | Values: 165.0 168.0 168.0 167.0 173.0 169.0 167.0 167.0 169.0 167.0 06:58:10 INFO - PROCESS | 16523 | 06:58:10 INFO - PROCESS | 16523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.11 (3.2%) stddev-sans-first:2.22 06:58:10 INFO - PROCESS | 16523 | Values: 66.0 65.0 65.0 71.0 64.0 65.0 64.0 65.0 64.0 64.0 06:58:10 INFO - PROCESS | 16523 | -------- Summary: end -------- 06:58:10 INFO - PROCESS | 16523 | 06:58:11 INFO - TEST-INFO | 16523: exit 0 06:58:11 INFO - TEST-OK | kraken | took 62165ms 06:58:11 INFO - SUITE-END | took 1180s 06:58:12 INFO - Completed test suite (00:19:41) 06:58:12 INFO - javascript benchmark 06:58:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3004.7896647234693, 3045.3452507710854, 3054.6792586778392, 3081.784275100744, 3100.6589275179726, 5099.260607211952, 5202.0376230397405, 5253.658512196705, 5329.733513324333, 5340.599455040878, 5128.846134615958, 5157.845264642057, 5232.424433312332, 5257.86855328617, 5270.578353731692, 4803.087413391444, 4831.589314908237, 4847.757612119398, 4860.708357498544, 4905.2642103684375, 4908.8281910133155, 4941.876453088666, 4948.975255123737, 4956.2070068789, 4981.153203955337, 4684.110019096361, 4751.216049351853, 4751.738654374008, 4839.395075615548, 4839.951600483985, 4787.928181077286, 4802.783874725646, 4803.663743537953, 4805.0, 4809.9038019239415, 4762.333273341735, 4763.095011947719, 4763.571278584944, 4771.1173432914675, 4779.020300838354, 5168.198929165986, 5215.530602245816, 5217.087009773274, 5218.921716174261, 5232.398274198478, 5550.139728342114, 5585.441455854423, 5624.634398764068, 5635.49280564747, 5640.520555752766, 5547.223388725542, 5561.63849349791, 5676.035074037382, 5696.829095127153, 5704.372519022904, 5219.451957544441, 5259.921101183485, 5271.973640131851, 5272.657277276965, 5276.419593844674, 5519.31008623922, 5750.88498230033, 5764.827055188351, 5773.797917072882, 5850.531957443394, 5337.146056630921, 5414.566834653218, 5505.311836020497, 5505.476979687003, 5508.669479831223, 5571.220029195916, 5584.246126772915, 5598.356189038232, 5599.972000140055, 5601.579881508903, 5562.443755624486, 5570.944290557123, 5583.162525621189, 5583.944160558423, 5643.125315576092, 5394.91907621386, 5463.31708536433, 5516.586256030814, 5598.0, 5598.944010559923, 4373.781310934441, 4378.387025816324, 4380.16776812411, 4423.867283981485, 4427.335899615019, 3875.302445559826, 3910.3743401055694, 3934.567197608261, 3947.842086316515, 3948.6446219840354, 5057.367829021372, 5100.719460429637, 5101.0308041472, 5229.633925625246, 5360.8659783504945, 5479.6164268500825, 5599.412061733459, 5599.7480113394995, 5612.438756124437, 5612.522935550524, 5274.630775845731, 5284.947150528523, 5298.072837253465, 5331.147016477423, 5349.759260833272, 4786.210275304606, 4838.346823178897, 4847.127517046965, 4852.781624826821, 4888.682235654671, 5600.663960162403, 5607.663540187602, 5675.517581005661, 5750.827475175752, 5764.971175144181, 5526.060569703241, 5541.141123125761, 5560.666360018412, 5625.88748225025, 5631.2960879890015, 5649.802256920988, 5697.886042279214, 5710.5146062585145, 5714.314282286152, 5717.285339332583, 5374.973125134506, 5391.568674506108, 5439.5920305976415, 5439.700816455133, 5448.264484294569, 5539.169124631338, 5599.1041433370465, 5600.831975040755, 5616.410276921028, 5679.943200567942, 5337.412884582615, 5352.384475785178, 5361.678299302054, 5363.946360536344, 5367.731613419235, 5222.738863056756, 5382.434844341287, 5390.110631745718, 5392.5416339611575, 5448.700321482356, 5300.946990530046, 5332.22682710997, 5345.305110335631, 5357.973210133924, 5414.7021913795115, 5328.786848526171, 5360.115580929259, 5371.892562148813, 5378.435264297349, 5380.354357477127, 5176.7152806596, 5239.659422137549, 5256.342957130359, 5258.290130832289, 5310.336207974004], "value": 5150.904541239083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.8283790605959, 554.8890221955608, 555.4417810100847, 556.9665820050798, 567.9918145292108, 28406.573901391497, 29000.274993125182, 35493.64506354939, 36563.45154822673, 36695.449568256496, 36927.63072369275, 37298.06754831131, 37539.81230093852, 37564.81217593915, 37651.24697506048, 8494.405391622573, 8626.094260102693, 8637.39538232324, 8638.09300023498, 8647.092055334193, 7906.130325664172, 8129.390295727814, 8500.957495212515, 9996.150327222194, 10294.227932905025, 10379.48102594871, 10415.218858585637, 10463.947680261588, 10467.4766261687, 10476.371417714961, 10280.280380373377, 10314.948425257826, 10335.379877207353, 10415.375077495375, 10420.0, 7619.0, 7876.763697089096, 9727.708168754878, 10058.59765609382, 10088.596456141746, 32518.0, 32858.34283314344, 32902.0, 32934.83532582322, 32937.6706232937, 2893.450244453547, 3063.1576316512915, 3086.845657717105, 3110.440120778259, 3292.407366673998, 27459.725402745917, 27797.722022779715, 27838.3040423989, 28359.149225523266, 29132.70867291321, 4184.225918205111, 4231.576842315774, 4345.217860785057, 4411.404460397869, 4442.911141777146, 318398.0, 318712.0, 319110.0, 319484.0, 319991.0, 41646.0, 41911.37132943008, 41973.160536789095, 42090.0, 42229.15541689211, 47163.0, 47195.864537609894, 47201.29198062032, 47227.0, 47297.52702473, 12530.624081277576, 13012.21926684402, 13085.607431777062, 13094.083414161109, 13137.211767293993, 8958.462492250486, 10277.331973421704, 10461.163106951426, 10483.266171368083, 10488.790224195473, 12012.939935300443, 12679.429425675868, 13036.869631303754, 13052.21686698801, 13431.462741490426, 5429.511343979061, 5458.645188062763, 5462.508374246337, 5578.888422231614, 5613.438656134354, 838.5974732128491, 896.6278994217457, 930.4370855632245, 931.2177770672668, 946.3470205558143, 26573.734262657512, 27495.725042749717, 27624.0, 27700.476473793733, 27722.5841612376, 945.0, 945.4185675809327, 987.5309228116587, 1012.4330374989881, 1027.111548510533, 14317.427302907976, 14508.763666113166, 14574.489892853699, 14689.92655036718, 14757.631059223606, 141258.2937085308, 142159.0, 143067.2846635781, 143715.0, 144333.0, 46109.0, 46153.307700384525, 46185.0, 46238.768806156426, 46261.0, 1095.7260684828634, 1109.0351394287022, 1127.4081107418506, 1138.163449864349, 1145.9656210313703, 26049.6092558608, 27389.589156162274, 27551.586726199523, 28127.0, 28291.575626366033, 40616.593834061285, 40994.79502602468, 41011.384829228184, 41022.179556409304, 41041.1791764169, 420095.0, 421975.0, 422532.0, 423097.0, 423293.0, 26314.21057368282, 28428.0, 29097.272568185967, 33025.55078412131, 33650.66349336573, 35234.29531409306, 38503.0, 38664.6133538661, 38731.0, 38793.80603096967, 32851.67148328486, 33274.833625831714, 33332.16669583183, 33462.0, 33537.329253415286, 32583.674163258063, 32630.51054234236, 33253.83373083216, 33510.0, 34074.829625851715, 33186.33627327488, 33900.152496187795, 33985.830070850476, 34060.14849628779, 34417.13957151091, 29126.56310155307, 30132.24669383283, 30781.538276925417, 30806.0, 30849.383012340077, 24507.632385513876, 24634.384140396633, 24671.876640616683, 24701.50596988014, 24752.25743227706], "value": 16881.266536021405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.7099333513195, 377.5529416428013, 385.26799081744684, 397.47334781414617, 399.48067512234087, 15534.22328883557, 17580.64838703225, 17725.82274177258, 17836.55408614785, 17884.016379099143, 15232.238388080606, 15572.922135389335, 15944.840551594481, 16150.596235094128, 16564.503064908044, 5390.1914712793105, 5632.746526406301, 5639.210510528529, 5645.040343141676, 5647.1529270609535, 4017.337139372, 4142.109446469009, 4215.093754842708, 4267.573242675739, 5497.862553436176, 6132.0, 6165.445109940105, 6273.5922165059355, 6277.340879207686, 6277.874442511147, 5477.3427188737205, 5753.367129615739, 5782.3350314713925, 6251.0, 6253.1245625612455, 5625.437456254383, 5674.914876276859, 5676.801311954103, 5683.8010669626365, 5685.772569097231, 13506.729865402735, 17066.658666826595, 19545.0, 20717.928207179313, 20894.164233430645, 2174.565086982594, 2313.8958746856433, 2480.7891329237036, 2602.7267136950536, 2770.875310611007, 9537.618495260182, 9613.327067105236, 10057.195424366033, 10063.496825158785, 12847.807282890764, 1812.4109664359137, 1822.7448157257995, 1843.0324079858183, 1866.2628261836498, 1887.4903775980408, 74564.0, 76455.0, 78042.60978695127, 81167.5941620294, 83309.16690833075, 10287.691369258935, 10488.68533943983, 10602.0, 10790.568377264979, 10806.837897431546, 14444.0, 14447.85552144486, 14472.710545789025, 14473.493427729978, 14503.347349369304, 6927.134108236471, 7143.678534465961, 7160.711072007089, 7305.4886157969495, 7373.446991475661, 6669.233038200572, 6700.296468870796, 6795.864082718318, 6848.212455567574, 6943.930560694429, 4322.632576231055, 4454.621357184611, 4471.28459446487, 4567.931481027787, 4607.308903664477, 1842.2907180735513, 1844.2069909938587, 1884.1050501012185, 1893.0, 1915.243478825856, 738.3354980517577, 806.9193080692002, 825.9917400826035, 854.6581367453068, 886.3751055505853, 16578.75131873023, 16697.582560435843, 17320.480385588453, 17629.118544072746, 17767.555811104827, 853.5220276645099, 857.7383897911197, 862.5342315149749, 885.8715486254457, 923.9076092390842, 9226.90773092274, 9402.34183607141, 9469.147776699992, 9578.664746733832, 9711.951440242754, 419897.0, 427617.0, 444757.0, 444872.0, 447212.0, 85304.0, 85527.0, 91117.61029871267, 91237.0, 92269.0, 861.7242482405695, 872.3544577012965, 899.3569597737518, 918.3250311021394, 918.7060140754894, 15350.539483815503, 15618.687626247638, 15706.528804135894, 15730.528084157493, 16210.432634857723, 36980.63019369772, 37015.70445034411, 39130.41304380493, 39480.0, 41530.0, 46605.095605065566, 49172.0, 51658.48341516537, 53367.4663253378, 54605.45394546004, 7811.687532498637, 7927.5243485391065, 7969.960150199212, 8245.505269683837, 8301.128381520095, 11282.661520154408, 12217.816732749194, 12264.141510094209, 12497.750044998867, 12938.870611294144, 10925.617603383844, 11041.834372484258, 11210.831837522606, 11316.886831131913, 11458.885411145782, 10097.545610447694, 10145.89854101479, 10170.389776613427, 10460.738481538023, 10623.203259755395, 9816.852747208655, 10849.837252441377, 10991.450427478754, 11372.488238029144, 11772.470238839443, 8045.436819422584, 8092.757217283491, 8382.706605268786, 8390.748277551684, 8427.367947403847, 9782.309864787241, 11288.153388495732, 11556.711082223012, 11738.237014594024, 11889.821652675044], "value": 8548.053704094527, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1104.7017305327556, 1176.705823544114, 1192.701824543864, 1244.4648801015562, 1396.3437184523277, 7450.217727138654, 8344.207300306469, 8673.69642062528, 8699.304055675546, 8908.020117787039, 8725.869111963326, 8730.60712267948, 8796.428232164904, 8798.736037918872, 8813.4711917285, 2294.8508346957437, 2319.118734880751, 2323.7327707313707, 2326.7789559991775, 2333.708286464192, 2270.886455677218, 2297.8046866016407, 2343.0, 2347.096367898363, 2348.6711860339565, 2262.4570103175283, 2296.47181148336, 2296.5406918616345, 2323.8605683659034, 2326.9069237230574, 2265.1166045242367, 2273.7498875123724, 2282.2354511238755, 2283.748787633359, 2283.931482055541, 2225.7329120505483, 2245.023414814561, 2249.640057590794, 2254.7745225477483, 2264.62633665445, 8648.30813534922, 8659.48043117415, 8693.782655433664, 8777.605007774666, 8807.64769409223, 5122.974385128088, 5249.553787928031, 5253.343332083489, 5261.1319132343115, 5266.315379000744, 3185.681431856819, 3352.4636058230567, 3400.0, 3418.3163367326633, 3460.8269586520573, 1213.071999920062, 1218.585680868509, 1222.2299951030882, 1249.775040492711, 1251.3367915004972, 12979.091463597646, 12979.41592628334, 13004.804927926089, 13019.739605207842, 13093.47626094955, 4199.013231890503, 4311.6335111515245, 4398.142362239332, 4435.756033418128, 4561.429821272341, 9559.90440095604, 9567.521623918776, 9579.760505987406, 9581.0, 9581.856272155923, 5141.048905952411, 5157.716325602053, 5159.045576568272, 5161.174212126042, 5163.612729045261, 4089.734167279117, 4217.451731274915, 4604.976975115103, 4724.598409135262, 4829.5653391194255, 3590.8922732318074, 3673.632636736305, 3711.402018586946, 3735.402335626287, 3742.8128593570214, 1137.4824454873178, 1149.5458245319678, 1151.153901882116, 1163.4182908545727, 1173.7359094203907, 733.8789099798473, 790.9835860918691, 838.2288294768828, 841.1966571923798, 844.2233145506149, 5662.546996240291, 5684.744186511617, 5697.430256974352, 5704.429557044263, 5914.4381283777975, 425.84882366759973, 431.42189466115553, 431.5188564750281, 886.7339798060556, 909.9208309013871, 3610.6750392464805, 3918.2359439908946, 3983.6016398359934, 3991.201759648082, 3998.6001399859783, 10889.673309800719, 10943.343399396063, 11136.443177841076, 11162.051225645748, 11168.497417616065, 11014.284071535325, 11126.721831954266, 11158.944205278922, 11176.161787865942, 11210.495527701272, 8138.348932085419, 8321.542315172723, 8345.54099524532, 8352.290055345242, 8353.081161072278, 5795.710214489174, 5841.737121829613, 5868.67722275279, 5989.431004054608, 6073.817785466443, 10183.18534517222, 10520.631777887736, 10609.575616975235, 10616.522256498321, 10720.571177153139, 10853.240273180802, 10864.891351086388, 10870.45647717595, 10891.891081089088, 10894.67315980522, 6907.205671347659, 7110.4667149962925, 7272.127344718668, 7695.345895598937, 7852.6073696313815, 8237.546934918637, 8548.23065924045, 8587.184217499327, 8640.956795215983, 8662.0, 7629.504082234637, 7664.616769161631, 7761.805954850948, 7826.373890088893, 7944.761657150295, 7340.743073992385, 7462.813429664302, 7483.139438964588, 7503.812404689927, 7726.227377262228, 6830.282820303796, 6927.58434493932, 6933.7226510939, 6937.098177236927, 6941.167059952636, 4758.595519380753, 4846.684965477232, 4848.878778030577, 4922.975385123052, 4978.576820970258, 4861.638741152483, 4873.195922672861, 4898.142825005539, 4975.129352363249, 5094.057599344133], "value": 4478.592674773562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.57460406223174, 310.36840030537854, 319.11604854552905, 319.59251953758957, 322.8627833170903, 4784.83253086142, 5077.289179514871, 5237.921431178531, 5281.313429254196, 5281.630285879985, 5116.258142569325, 5182.481751824816, 5198.3761948566225, 5215.973920130394, 5220.29526013988, 4129.132882094764, 4132.982922466601, 4134.64855487284, 4138.461999940004, 4140.648044916194, 3918.5689574146822, 4148.585141485857, 4150.588799808064, 4156.5012198536215, 4159.355299928516, 3793.180854513254, 4036.596340365955, 4040.1111755413763, 4060.7563546187175, 4084.530279017921, 4045.2314060328736, 4052.2705912935808, 4055.0, 4066.7356621819486, 4067.0239142605856, 3590.120420496969, 3592.46113083037, 3593.3711600469815, 3593.9820300898327, 3606.891793246207, 4896.4858689837765, 5011.624128190364, 5044.344235249431, 5051.696898186084, 5097.5667068299235, 4576.588107070346, 4586.564276393738, 4592.47186573545, 4593.494715581283, 4594.862154135381, 5389.164679474688, 5413.431589683066, 5419.647722897999, 5440.91838622421, 5446.618736688433, 3759.586445490994, 3830.5403351597706, 3846.903827404309, 3862.903427414309, 3904.7657140571655, 5368.926214757064, 5546.362168350692, 5605.691686957216, 5605.80379686709, 5607.495325420732, 3776.962230377716, 3916.373380259145, 3924.529056513237, 3924.95988563031, 3927.0378757204667, 3955.0, 3962.9101996951067, 3963.6630886374983, 3974.205158968218, 3974.82113304902, 4545.2954792007295, 4546.0680560485025, 4553.681242313072, 4564.338170965191, 4565.338025986213, 5259.395169555473, 5429.67421954684, 5438.91841622376, 5459.689674478176, 5463.808766693147, 1325.1651459580403, 1338.6921008168176, 1341.4298922957898, 1342.5435351980373, 1346.2393747532808, 832.9167083291622, 872.9388942773945, 880.3229847141206, 882.7925437522177, 885.1679421343916, 4709.3877795887, 4711.149754398608, 4720.291956206596, 4728.243481043085, 4733.053389322149, 4878.682885612424, 4906.435759887659, 4919.87700307488, 4922.360093187863, 4922.556969872729, 4434.84478043267, 4701.918558731442, 4721.787519561628, 4757.643176761757, 4761.47623761386, 2630.3954587701487, 2632.0, 2640.194740604134, 2649.7482739140137, 2657.521646103681, 5107.821226257138, 5125.64120511568, 5129.076596276396, 5140.3831540215415, 5147.536721695065, 4861.708297502161, 5068.288465670848, 5077.461269365317, 5081.644284900021, 5087.26234695967, 5109.824740309749, 5118.310957384128, 5121.28302037715, 5121.743912804271, 5122.282880396748, 4873.805047798049, 4886.849786094107, 4922.290143433743, 4941.802327906844, 4946.307516947558, 4560.361549383156, 4834.854954351375, 4861.51384861511, 4866.221404575251, 4893.657443979029, 4938.38270216223, 5010.273510341053, 5463.453654634504, 5602.982926146503, 5655.7454914528125, 3985.5815139409942, 3987.282289187858, 3993.740406873544, 3995.780232087263, 4006.659433948147, 5626.212330273846, 5626.803061892814, 5627.465390787868, 5635.718214089361, 5645.661260324394, 5141.38303403594, 5277.733343997336, 5314.415414304346, 5329.493698098674, 5352.384475785335, 5278.89442211146, 5285.207218917193, 5286.171898034687, 5309.973450132725, 5324.988252232063, 5381.865453363697, 5413.431589683184, 5417.945820541744, 5426.182228953345, 5439.912017596417, 5164.7417629119145, 5382.623216374816, 5444.074507333684, 5453.563714902719, 5454.59090568201, 5287.629865909349, 5289.788408463773, 5296.9670914171365, 5307.6465501296925, 5308.097623404108], "value": 3995.9353936767743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.2415032908207, 599.9010163323052, 629.6395140803997, 652.2694582068084, 670.996645016775, 12980.156289841178, 13504.662383440407, 14046.929765351158, 14055.859441405582, 14086.225257610828, 12287.877121228785, 12319.384030798468, 12377.071719621043, 12432.378381080955, 12486.750264994695, 573.6070791507809, 584.0888214385551, 584.8976429124907, 585.0463744097116, 585.8769658371747, 501.0255053920127, 511.93600799900014, 512.1651707716417, 512.8487096306579, 575.4130786597668, 591.6745789815606, 606.9666168360739, 608.367298010069, 610.560396514511, 612.2347066167291, 601.2334273800917, 602.01570432343, 602.1209034809184, 603.0923460192404, 603.2158194347331, 383.8253594614472, 437.7986126381868, 438.00572699971207, 438.29653406282773, 438.46507261141676, 10175.185985121172, 10605.31065480749, 10617.0, 11072.0, 11763.764724705457, 13408.932955335258, 13711.657208569766, 13901.930490347484, 14073.0, 14163.291835408292, 11356.375399353032, 11403.429828508624, 11466.369349685847, 11674.708132296675, 11741.765164696659, 3766.1714422826935, 3791.109089363997, 3796.0509872531866, 3810.90472738181, 3974.920501589952, 75542.62228688876, 76852.61573692095, 77598.6120069396, 78888.21111788866, 80937.59531202307, 10359.223058270509, 10385.273030887916, 10477.0, 10520.421376824195, 10652.0, 19265.51836204106, 19304.420867374, 19339.419817405218, 19341.226350946086, 19349.322773702854, 6954.200266969262, 7015.0, 7612.391008719289, 7876.763697089096, 8044.557549334842, 4327.069680018811, 4413.337999300131, 4431.446069241345, 4570.343943474463, 4636.142313671981, 3255.5116732490314, 3359.0930448778695, 3379.374815659111, 3379.797212167278, 3383.9323213536086, 554.4289381936612, 555.303094616254, 567.2059117235821, 573.3778849947853, 575.7840809696364, 521.9504147106019, 560.7224423910191, 561.1806762127339, 569.4135040907871, 609.9664518451439, 8445.259355325907, 8807.251383632334, 8825.955870220609, 9141.0, 9159.90840091604, 500.44200716201175, 530.6921985248547, 533.8265063854263, 555.1506195520859, 581.1805354450205, 3860.9227815444096, 3906.570277269498, 4183.184279065614, 4194.832206711759, 4237.703360764717, 109223.0, 110999.44500277448, 112973.43513282546, 116514.0, 116535.0, 99070.0, 99332.50333748285, 99638.0, 99822.0, 101837.49081254547, 91193.99999999868, 91872.54063729772, 92415.53792230996, 92582.53708731548, 93835.17131744947, 7737.381009519112, 7811.257930496594, 7830.41271904598, 7866.7639970800965, 8158.143394943446, 50128.0, 50446.74776626093, 52181.47818521766, 52199.73900130475, 52234.73882630715, 72556.6372168157, 75370.0, 76379.66230278925, 77728.61135694286, 79093.0, 9512.762180945532, 9811.116999470081, 9884.159846413135, 9937.10566049059, 10149.23880708935, 12108.091893107876, 12152.878471215528, 12489.18820276679, 12694.0, 13266.602001939957, 10941.890581094405, 10971.945140274247, 11121.888781112086, 11206.719832004264, 11609.419529023684, 11428.485718142538, 11520.94239528797, 11567.363794991019, 12000.699982500508, 12456.252624842538, 10199.592016319264, 10686.73283167927, 10766.0, 10766.0, 11092.889071109186, 9111.225545828678, 9378.062193780568, 9440.575174117319, 9807.411555306704, 10020.69937901864, 8859.424137431046, 9366.203872670627, 9580.281478888972, 9665.323427360017, 9692.903070969482], "value": 6507.916046723413, "unit": "score"}], "name": "dromaeo_css", "value": 6651.197809663205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 112.0, 109.0, 110.0, 110.0, 110.0, 109.0, 108.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 128.0, 171.0, 124.0, 123.0, 124.0, 123.0, 152.0, 122.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 159.0, 162.0, 160.0, 163.0, 161.0, 164.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 122.0, 76.0, 77.0, 76.0, 77.0, 108.0, 77.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 112.0, 82.0, 83.0, 83.0, 113.0, 82.0, 82.0, 110.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 50.0, 51.0, 52.0, 52.0, 52.0, 52.0, 50.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 63.0, 61.0, 62.0, 62.0, 63.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 88.0, 82.0, 79.0, 88.0, 79.0, 79.0, 79.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 139.0, 132.0, 145.0, 130.0, 131.0, 142.0, 163.0, 131.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 168.0, 167.0, 173.0, 169.0, 167.0, 167.0, 169.0, 167.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 71.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1504.3, "alertThreshold": 2.0}]} 06:58:12 INFO - Return code: 0 06:58:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:58:12 INFO - # TBPL SUCCESS # 06:58:12 INFO - Running post-action listener: _resource_record_post_action 06:58:12 INFO - [mozharness: 2016-10-05 13:58:12.169273Z] Finished run-tests step (success) 06:58:12 INFO - Running post-run listener: _resource_record_post_run 06:58:12 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 404316160; Read time: 0; Write time: 371524 06:58:12 INFO - TinderboxPrint: CPU usage
13.1% 06:58:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:58:12 INFO - TinderboxPrint: I/O write bytes / time
404,316,160 / 371,524 06:58:12 INFO - TinderboxPrint: CPU idle
8,303.6 (86.9%) 06:58:12 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 06:58:12 INFO - TinderboxPrint: Swap in / out
0 / 0 06:58:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114503680; Read time: 0; Write time: 110752 06:58:12 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289333248; Read time: 0; Write time: 260748 06:58:12 INFO - Running post-run listener: _upload_blobber_files 06:58:12 INFO - Blob upload gear active. 06:58:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:58:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:58:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:14 INFO - (blobuploader) - INFO - Done attempting. 06:58:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:58:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:17 INFO - (blobuploader) - INFO - Done attempting. 06:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:18 INFO - (blobuploader) - INFO - Done attempting. 06:58:18 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:18 INFO - Return code: 0 06:58:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae37cb3bac78682440900f45386b6968d06b2701405565612376d8b101540c0399a24fbf1614f850bb541c2b37a367f780d61d60c09f47d0e3c44059572776e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e8925b9a96c83b774620edc555affe8c63646834284339ba062bafeed47b9be944f2e1010e90d07c32895ac486363879dfd01bf2dc81a520b40d39d4e14fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6516895ed8a88f28e96b0454fd8641be816e1b9253156fce07e45d0b59600e1bb47cbdb559d0fcc612066798cc7b0ee54bd4542dd97437288a8ec6cf6c8b07"} 06:58:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:18 INFO - Contents: 06:58:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae37cb3bac78682440900f45386b6968d06b2701405565612376d8b101540c0399a24fbf1614f850bb541c2b37a367f780d61d60c09f47d0e3c44059572776e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e8925b9a96c83b774620edc555affe8c63646834284339ba062bafeed47b9be944f2e1010e90d07c32895ac486363879dfd01bf2dc81a520b40d39d4e14fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6516895ed8a88f28e96b0454fd8641be816e1b9253156fce07e45d0b59600e1bb47cbdb559d0fcc612066798cc7b0ee54bd4542dd97437288a8ec6cf6c8b07"} 06:58:18 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:18 INFO - Copying logs to upload dir... 06:58:18 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.359779 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-05 06:58:17.517450) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 06:58:17.521116) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae37cb3bac78682440900f45386b6968d06b2701405565612376d8b101540c0399a24fbf1614f850bb541c2b37a367f780d61d60c09f47d0e3c44059572776e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e8925b9a96c83b774620edc555affe8c63646834284339ba062bafeed47b9be944f2e1010e90d07c32895ac486363879dfd01bf2dc81a520b40d39d4e14fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6516895ed8a88f28e96b0454fd8641be816e1b9253156fce07e45d0b59600e1bb47cbdb559d0fcc612066798cc7b0ee54bd4542dd97437288a8ec6cf6c8b07"} build_url:https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011568 build_url: 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae37cb3bac78682440900f45386b6968d06b2701405565612376d8b101540c0399a24fbf1614f850bb541c2b37a367f780d61d60c09f47d0e3c44059572776e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e8925b9a96c83b774620edc555affe8c63646834284339ba062bafeed47b9be944f2e1010e90d07c32895ac486363879dfd01bf2dc81a520b40d39d4e14fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6516895ed8a88f28e96b0454fd8641be816e1b9253156fce07e45d0b59600e1bb47cbdb559d0fcc612066798cc7b0ee54bd4542dd97437288a8ec6cf6c8b07"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 06:58:17.552361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:58:17.553184) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1475674655.385215-1738894235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:58:17.634844) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 06:58:17.635187) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 06:58:17.635501) ========= ========= Total master_lag: 0.17 =========