builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1477537319.43 results: success (0) buildid: 20161026183135 builduid: f0396a5884a041fd893ed3c41d8cb70c revision: 54f7bdea89765bb113513f00000160f4dd25c317 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.433488) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.433977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.434260) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.457423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.457677) ========= 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=337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 20:02:00-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-26 20:02:00 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.565925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.566201) ========= 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=337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020658 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.614897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:01:59.615226) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 54f7bdea89765bb113513f00000160f4dd25c317 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 54f7bdea89765bb113513f00000160f4dd25c317 --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=337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 20:02:00,245 truncating revision to first 12 chars 2016-10-26 20:02:00,245 Setting DEBUG logging. 2016-10-26 20:02:00,245 attempt 1/10 2016-10-26 20:02:00,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/54f7bdea8976?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 20:02:00,676 unpacking tar archive at: mozilla-central-54f7bdea8976/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:02:00.371812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 20:02:00.372123) ========= script_repo_revision: 54f7bdea89765bb113513f00000160f4dd25c317 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 20:02:00.372541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 20:02:00.372811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 20:02:00.385520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-26 20:02:00.385817) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:02:01 INFO - MultiFileLogger online at 20161026 20:02:01 in /builds/slave/test 20:02:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:02:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:02:01 INFO - {'append_to_log': False, 20:02:01 INFO - 'base_work_dir': '/builds/slave/test', 20:02:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:02:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:02:01 INFO - 'branch': 'Firefox-Non-PGO', 20:02:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:02:01 INFO - 'config_files': ('talos/linux_config.py',), 20:02:01 INFO - 'default_actions': ('clobber', 20:02:01 INFO - 'read-buildbot-config', 20:02:01 INFO - 'download-and-extract', 20:02:01 INFO - 'populate-webroot', 20:02:01 INFO - 'create-virtualenv', 20:02:01 INFO - 'install', 20:02:01 INFO - 'run-tests'), 20:02:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:02:01 INFO - 'download_minidump_stackwalk': True, 20:02:01 INFO - 'download_symbols': 'ondemand', 20:02:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:02:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:02:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:02:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:02:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:02:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:02:01 INFO - 'installer_path': 'installer.exe', 20:02:01 INFO - 'log_level': 'info', 20:02:01 INFO - 'log_name': 'talos', 20:02:01 INFO - 'log_to_console': True, 20:02:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:02:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:02:01 INFO - 'opt_config_files': (), 20:02:01 INFO - 'pip_index': False, 20:02:01 INFO - 'sps_profile': False, 20:02:01 INFO - 'sps_profile_interval': 0, 20:02:01 INFO - 'suite': 'dromaeojs', 20:02:01 INFO - 'system_bits': '32', 20:02:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:02:01 INFO - 'title': 'talos-linux64-ix-060', 20:02:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:02:01 INFO - 'use_talos_json': True, 20:02:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:02:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:02:01 INFO - 'work_dir': 'build'} 20:02:01 INFO - [mozharness: 2016-10-27 03:02:01.114564Z] Running clobber step. 20:02:01 INFO - Running pre-action listener: _resource_record_pre_action 20:02:01 INFO - Running main action method: clobber 20:02:01 INFO - rmtree: /builds/slave/test/build 20:02:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:02:02 INFO - Running post-action listener: _resource_record_post_action 20:02:02 INFO - [mozharness: 2016-10-27 03:02:02.094733Z] Finished clobber step (success) 20:02:02 INFO - [mozharness: 2016-10-27 03:02:02.094854Z] Running read-buildbot-config step. 20:02:02 INFO - Running pre-action listener: _resource_record_pre_action 20:02:02 INFO - Running main action method: read_buildbot_config 20:02:02 INFO - Using buildbot properties: 20:02:02 INFO - { 20:02:02 INFO - "project": "", 20:02:02 INFO - "product": "firefox", 20:02:02 INFO - "script_repo_revision": "production", 20:02:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:02:02 INFO - "repository": "", 20:02:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:02:02 INFO - "buildid": "20161026183135", 20:02:02 INFO - "pgo_build": "False", 20:02:02 INFO - "basedir": "/builds/slave/test", 20:02:02 INFO - "buildnumber": 270, 20:02:02 INFO - "slavename": "talos-linux64-ix-060", 20:02:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:02:02 INFO - "platform": "ubuntu64_hw", 20:02:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:02:02 INFO - "branch": "mozilla-central", 20:02:02 INFO - "repo_path": "mozilla-central", 20:02:02 INFO - "revision": "54f7bdea89765bb113513f00000160f4dd25c317", 20:02:02 INFO - "stage_platform": "linux64", 20:02:02 INFO - "builduid": "f0396a5884a041fd893ed3c41d8cb70c", 20:02:02 INFO - "slavebuilddir": "test" 20:02:02 INFO - } 20:02:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:02:02 INFO - Running post-action listener: _resource_record_post_action 20:02:02 INFO - [mozharness: 2016-10-27 03:02:02.097351Z] Finished read-buildbot-config step (success) 20:02:02 INFO - [mozharness: 2016-10-27 03:02:02.097439Z] Running download-and-extract step. 20:02:02 INFO - Running pre-action listener: _resource_record_pre_action 20:02:02 INFO - Running main action method: download_and_extract 20:02:02 INFO - mkdir: /builds/slave/test/build/tests 20:02: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')]} 20:02:02 INFO - trying https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:02:02 INFO - Downloading https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/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 20:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/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 20:02:02 INFO - Downloaded 1361 bytes. 20:02:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:02:02 INFO - Using the following test package requirements: 20:02:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:02:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'jsshell-linux-x86_64.zip'], 20:02:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:02:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:02:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:02:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:02 INFO - Fetch https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:02:03 INFO - Http code: 200 20:02:03 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 20:02:03 INFO - x-amz-cf-id: a_My3QQFB5a90WGN-o7gOMSsfOpiheC36Ax4puWvR4wzBPGkhasn8A== 20:02:03 INFO - x-amz-version-id: CE_Tx4UIA1vkRkwtjH21FYQuuG_rpck6 20:02:03 INFO - Expected file size: 20422969 20:02:03 INFO - Obtained file size: 20422969 20:02:07 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 20:02:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:02:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:02:08 INFO - Http code: 200 20:02:08 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 20:02:08 INFO - x-amz-cf-id: ufJNKLcWWV3Pj_wsbfXLQidBSKbduzZ9Dud_fpvrpNi_nmT994dL-g== 20:02:08 INFO - x-amz-version-id: CE_Tx4UIA1vkRkwtjH21FYQuuG_rpck6 20:02:08 INFO - Expected file size: 20422969 20:02:08 INFO - Obtained file size: 20422969 20:02:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:02:12 INFO - Fetch https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:02:13 INFO - Http code: 200 20:02:13 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 20:02:13 INFO - x-amz-cf-id: hcIcag3W2RRzRuaj1YOxAsMD8w6pLTXLn6YPJa_ot8e5wnhFtCA1RQ== 20:02:13 INFO - x-amz-version-id: RFm4cMrcn1fimTFcjmOSEYj9XkhBfgpS 20:02:13 INFO - Expected file size: 14409028 20:02:13 INFO - Obtained file size: 14409028 20:02: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')]} 20:02:13 INFO - trying https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:02:13 INFO - Downloading https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/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 20:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/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 20:02:15 INFO - Downloaded 55577309 bytes. 20:02:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:02:15 INFO - mkdir: /builds/slave/test/properties 20:02:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:02:15 INFO - Writing to file /builds/slave/test/properties/build_url 20:02:15 INFO - Contents: 20:02:15 INFO - build_url:https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:02:16 INFO - Running post-action listener: _resource_record_post_action 20:02:16 INFO - Running post-action listener: set_extra_try_arguments 20:02:16 INFO - [mozharness: 2016-10-27 03:02:16.090402Z] Finished download-and-extract step (success) 20:02:16 INFO - [mozharness: 2016-10-27 03:02:16.090627Z] Running populate-webroot step. 20:02:16 INFO - Running pre-action listener: _resource_record_pre_action 20:02:16 INFO - Running main action method: populate_webroot 20:02:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:02:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:02:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:02:16 INFO - '--tppagecycles', 20:02:16 INFO - '7'], 20:02:16 INFO - 'tests': ['tsvgm']}}, 20:02:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:02:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:02:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:02:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:02:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['damp', 'tps']}, 20:02:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'tests': ['damp', 'tps']}, 20:02:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['dromaeo_dom']}, 20:02:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:02:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['basic_compositor_video']}, 20:02:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:02:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['a11yr', 20:02:16 INFO - 'ts_paint', 20:02:16 INFO - 'tpaint', 20:02:16 INFO - 'sessionrestore', 20:02:16 INFO - 'sessionrestore_no_auto_restore', 20:02:16 INFO - 'tabpaint']}, 20:02:16 INFO - 'other-e10s': {'tests': ['a11yr', 20:02:16 INFO - 'ts_paint', 20:02:16 INFO - 'tpaint', 20:02:16 INFO - 'sessionrestore', 20:02:16 INFO - 'sessionrestore_no_auto_restore', 20:02:16 INFO - 'tabpaint']}, 20:02:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:02:16 INFO - 'ts_paint', 20:02:16 INFO - 'tpaint', 20:02:16 INFO - 'sessionrestore', 20:02:16 INFO - 'sessionrestore_no_auto_restore', 20:02:16 INFO - 'tabpaint']}, 20:02:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:02:16 INFO - 'ts_paint', 20:02:16 INFO - 'tpaint', 20:02:16 INFO - 'sessionrestore', 20:02:16 INFO - 'sessionrestore_no_auto_restore', 20:02:16 INFO - 'tabpaint']}, 20:02:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['a11yr', 20:02:16 INFO - 'ts_paint', 20:02:16 INFO - 'tpaint', 20:02:16 INFO - 'sessionrestore', 20:02:16 INFO - 'sessionrestore_no_auto_restore', 20:02:16 INFO - 'tabpaint']}, 20:02:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['a11yr', 20:02:16 INFO - 'ts_paint', 20:02:16 INFO - 'tpaint', 20:02:16 INFO - 'sessionrestore', 20:02:16 INFO - 'sessionrestore_no_auto_restore', 20:02:16 INFO - 'tabpaint']}, 20:02:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['tsvgx', 20:02:16 INFO - 'tsvgr_opacity', 20:02:16 INFO - 'tart', 20:02:16 INFO - 'tscrollx', 20:02:16 INFO - 'cart']}, 20:02:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:02:16 INFO - 'tsvgr_opacity', 20:02:16 INFO - 'tart', 20:02:16 INFO - 'tscrollx', 20:02:16 INFO - 'cart']}, 20:02:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'talos_options': ['--disable-e10s'], 20:02:16 INFO - 'tests': ['tp5o']}, 20:02:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'tests': ['tp5o']}, 20:02:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'talos_options': ['--disable-e10s', 20:02:16 INFO - '--xperf_path', 20:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:16 INFO - 'tests': ['tp5n']}, 20:02:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:16 INFO - 'talos_options': ['--xperf_path', 20:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:16 INFO - 'tests': ['tp5n']}}, 20:02:16 INFO - 'talos.zip': {'path': '', 20:02:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:02:16 INFO - Running post-action listener: _resource_record_post_action 20:02:16 INFO - [mozharness: 2016-10-27 03:02:16.109050Z] Finished populate-webroot step (success) 20:02:16 INFO - [mozharness: 2016-10-27 03:02:16.109137Z] Running create-virtualenv step. 20:02:16 INFO - Running pre-action listener: _resource_record_pre_action 20:02:16 INFO - Running main action method: create_virtualenv 20:02:16 INFO - Creating virtualenv /builds/slave/test/build/venv 20:02:16 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 20:02:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:02:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:02:16 INFO - Using real prefix '/usr' 20:02:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:02:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:02:18 INFO - Installing pip.................done. 20:02:18 INFO - Return code: 0 20:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:02:18 INFO - Reading from file tmpfile_stdout 20:02:18 INFO - Output received: 20:02:18 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) 20:02:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:02:18 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')]} 20:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:18 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')]} 20:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:18 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:18 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 20:02:18 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 20:02:18 INFO - Using env: {'DISPLAY': ':0', 20:02:18 INFO - 'HOME': '/home/cltbld', 20:02:18 INFO - 'LANG': 'en_US.UTF-8', 20:02:18 INFO - 'LANGUAGE': 'en_US:en', 20:02:18 INFO - 'LOGNAME': 'cltbld', 20:02:18 INFO - 'MAIL': '/var/mail/cltbld', 20:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:18 INFO - 'MOZ_NO_REMOTE': '1', 20:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:18 INFO - 'NO_EM_RESTART': '1', 20:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:18 INFO - 'PWD': '/builds/slave/test', 20:02:18 INFO - 'SHELL': '/bin/bash', 20:02:18 INFO - 'SHLVL': '1', 20:02:18 INFO - 'TERM': 'linux', 20:02:18 INFO - 'TMOUT': '86400', 20:02:18 INFO - 'USER': 'cltbld', 20:02:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:18 INFO - '_': '/tools/buildbot/bin/python'} 20:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:19 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 20:02:19 INFO - Cleaning up... 20:02:19 INFO - Return code: 0 20:02:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:02:19 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')]} 20:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:19 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')]} 20:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:19 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:19 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 20:02:19 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 20:02:19 INFO - Using env: {'DISPLAY': ':0', 20:02:19 INFO - 'HOME': '/home/cltbld', 20:02:19 INFO - 'LANG': 'en_US.UTF-8', 20:02:19 INFO - 'LANGUAGE': 'en_US:en', 20:02:19 INFO - 'LOGNAME': 'cltbld', 20:02:19 INFO - 'MAIL': '/var/mail/cltbld', 20:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:19 INFO - 'MOZ_NO_REMOTE': '1', 20:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:19 INFO - 'NO_EM_RESTART': '1', 20:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:19 INFO - 'PWD': '/builds/slave/test', 20:02:19 INFO - 'SHELL': '/bin/bash', 20:02:19 INFO - 'SHLVL': '1', 20:02:19 INFO - 'TERM': 'linux', 20:02:19 INFO - 'TMOUT': '86400', 20:02:19 INFO - 'USER': 'cltbld', 20:02:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:19 INFO - '_': '/tools/buildbot/bin/python'} 20:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:19 INFO - Downloading/unpacking psutil>=3.1.1 20:02:19 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 20:02:19 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 20:02:19 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 20:02:19 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 20:02:19 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 20:02:19 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 20:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:21 INFO - Installing collected packages: psutil 20:02:21 INFO - Running setup.py install for psutil 20:02:21 INFO - building 'psutil._psutil_linux' extension 20:02:21 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 20:02:21 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 20:02:21 INFO - building 'psutil._psutil_posix' extension 20:02:21 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 20:02:21 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 20:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:21 INFO - Successfully installed psutil 20:02:21 INFO - Cleaning up... 20:02:21 INFO - Return code: 0 20:02:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:02:21 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')]} 20:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:21 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')]} 20:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:21 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:21 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 20:02:21 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 20:02:21 INFO - Using env: {'DISPLAY': ':0', 20:02:21 INFO - 'HOME': '/home/cltbld', 20:02:21 INFO - 'LANG': 'en_US.UTF-8', 20:02:21 INFO - 'LANGUAGE': 'en_US:en', 20:02:21 INFO - 'LOGNAME': 'cltbld', 20:02:21 INFO - 'MAIL': '/var/mail/cltbld', 20:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:21 INFO - 'MOZ_NO_REMOTE': '1', 20:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:21 INFO - 'NO_EM_RESTART': '1', 20:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:21 INFO - 'PWD': '/builds/slave/test', 20:02:21 INFO - 'SHELL': '/bin/bash', 20:02:21 INFO - 'SHLVL': '1', 20:02:21 INFO - 'TERM': 'linux', 20:02:21 INFO - 'TMOUT': '86400', 20:02:21 INFO - 'USER': 'cltbld', 20:02:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:21 INFO - '_': '/tools/buildbot/bin/python'} 20:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:02:22 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 20:02:22 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 20:02:22 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 20:02:22 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 20:02:22 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 20:02:22 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 20:02:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:02:24 INFO - Installing collected packages: mozsystemmonitor 20:02:24 INFO - Running setup.py install for mozsystemmonitor 20:02:24 INFO - Successfully installed mozsystemmonitor 20:02:24 INFO - Cleaning up... 20:02:24 INFO - Return code: 0 20:02:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:02:24 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')]} 20:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:24 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')]} 20:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:24 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:24 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 20:02:24 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 20:02:24 INFO - Using env: {'DISPLAY': ':0', 20:02:24 INFO - 'HOME': '/home/cltbld', 20:02:24 INFO - 'LANG': 'en_US.UTF-8', 20:02:24 INFO - 'LANGUAGE': 'en_US:en', 20:02:24 INFO - 'LOGNAME': 'cltbld', 20:02:24 INFO - 'MAIL': '/var/mail/cltbld', 20:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:24 INFO - 'MOZ_NO_REMOTE': '1', 20:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:24 INFO - 'NO_EM_RESTART': '1', 20:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:24 INFO - 'PWD': '/builds/slave/test', 20:02:24 INFO - 'SHELL': '/bin/bash', 20:02:24 INFO - 'SHLVL': '1', 20:02:24 INFO - 'TERM': 'linux', 20:02:24 INFO - 'TMOUT': '86400', 20:02:24 INFO - 'USER': 'cltbld', 20:02:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:24 INFO - '_': '/tools/buildbot/bin/python'} 20:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:02:24 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 20:02:24 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 20:02:24 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 20:02:24 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 20:02:24 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 20:02:24 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 20:02:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:02:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:02:26 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 20:02:26 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 20:02:26 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 20:02:26 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 20:02:26 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 20:02:26 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 20:02:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:02:26 INFO - warning: no files found matching '*.txt' 20:02:26 INFO - no previously-included directories found matching 'build' 20:02:26 INFO - no previously-included directories found matching 'dist' 20:02:26 INFO - no previously-included directories found matching '.git*' 20:02:26 INFO - Installing collected packages: jsonschema, functools32 20:02:26 INFO - Running setup.py install for functools32 20:02:26 INFO - warning: no files found matching '*.txt' 20:02:26 INFO - no previously-included directories found matching 'build' 20:02:26 INFO - no previously-included directories found matching 'dist' 20:02:26 INFO - no previously-included directories found matching '.git*' 20:02:26 INFO - Successfully installed jsonschema functools32 20:02:26 INFO - Cleaning up... 20:02:26 INFO - Return code: 0 20:02:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:02:26 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')]} 20:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:26 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')]} 20:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:26 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:26 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 20:02:26 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 20:02:26 INFO - Using env: {'DISPLAY': ':0', 20:02:26 INFO - 'HOME': '/home/cltbld', 20:02:26 INFO - 'LANG': 'en_US.UTF-8', 20:02:26 INFO - 'LANGUAGE': 'en_US:en', 20:02:26 INFO - 'LOGNAME': 'cltbld', 20:02:26 INFO - 'MAIL': '/var/mail/cltbld', 20:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:26 INFO - 'MOZ_NO_REMOTE': '1', 20:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:26 INFO - 'NO_EM_RESTART': '1', 20:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:26 INFO - 'PWD': '/builds/slave/test', 20:02:26 INFO - 'SHELL': '/bin/bash', 20:02:26 INFO - 'SHLVL': '1', 20:02:26 INFO - 'TERM': 'linux', 20:02:26 INFO - 'TMOUT': '86400', 20:02:26 INFO - 'USER': 'cltbld', 20:02:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:26 INFO - '_': '/tools/buildbot/bin/python'} 20:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:02:27 INFO - Cleaning up... 20:02:27 INFO - Return code: 0 20:02:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:02:27 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')]} 20:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:27 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')]} 20:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:27 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:27 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 20:02:27 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 20:02:27 INFO - Using env: {'DISPLAY': ':0', 20:02:27 INFO - 'HOME': '/home/cltbld', 20:02:27 INFO - 'LANG': 'en_US.UTF-8', 20:02:27 INFO - 'LANGUAGE': 'en_US:en', 20:02:27 INFO - 'LOGNAME': 'cltbld', 20:02:27 INFO - 'MAIL': '/var/mail/cltbld', 20:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:27 INFO - 'MOZ_NO_REMOTE': '1', 20:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:27 INFO - 'NO_EM_RESTART': '1', 20:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:27 INFO - 'PWD': '/builds/slave/test', 20:02:27 INFO - 'SHELL': '/bin/bash', 20:02:27 INFO - 'SHLVL': '1', 20:02:27 INFO - 'TERM': 'linux', 20:02:27 INFO - 'TMOUT': '86400', 20:02:27 INFO - 'USER': 'cltbld', 20:02:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:27 INFO - '_': '/tools/buildbot/bin/python'} 20:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:27 INFO - Downloading/unpacking blobuploader==1.2.4 20:02:27 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 20:02:27 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 20:02:27 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 20:02:27 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 20:02:27 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 20:02:27 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 20:02:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:02:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:02:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 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 20:02:29 INFO - Downloading docopt-0.6.1.tar.gz 20:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:02:30 INFO - Installing collected packages: blobuploader, requests, docopt 20:02:30 INFO - Running setup.py install for blobuploader 20:02:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:02:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:02:30 INFO - Running setup.py install for requests 20:02:30 INFO - Running setup.py install for docopt 20:02:30 INFO - Successfully installed blobuploader requests docopt 20:02:30 INFO - Cleaning up... 20:02:30 INFO - Return code: 0 20:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02: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')]} 20:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02: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')]} 20:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:30 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:30 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 20:02:30 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 20:02:30 INFO - Using env: {'DISPLAY': ':0', 20:02:30 INFO - 'HOME': '/home/cltbld', 20:02:30 INFO - 'LANG': 'en_US.UTF-8', 20:02:30 INFO - 'LANGUAGE': 'en_US:en', 20:02:30 INFO - 'LOGNAME': 'cltbld', 20:02:30 INFO - 'MAIL': '/var/mail/cltbld', 20:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:30 INFO - 'MOZ_NO_REMOTE': '1', 20:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:30 INFO - 'NO_EM_RESTART': '1', 20:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:30 INFO - 'PWD': '/builds/slave/test', 20:02:30 INFO - 'SHELL': '/bin/bash', 20:02:30 INFO - 'SHLVL': '1', 20:02:30 INFO - 'TERM': 'linux', 20:02:30 INFO - 'TMOUT': '86400', 20:02:30 INFO - 'USER': 'cltbld', 20:02:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:30 INFO - '_': '/tools/buildbot/bin/python'} 20:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:30 INFO - Running setup.py (path:/tmp/pip-3rU9pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:30 INFO - Running setup.py (path:/tmp/pip-8kDfNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:31 INFO - Running setup.py (path:/tmp/pip-l3NnQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:31 INFO - Running setup.py (path:/tmp/pip-JNaZsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:31 INFO - Running setup.py (path:/tmp/pip-cymttF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:31 INFO - Running setup.py (path:/tmp/pip-YZ9Ecf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:31 INFO - Running setup.py (path:/tmp/pip-12OAc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:31 INFO - Running setup.py (path:/tmp/pip-w1xeT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:31 INFO - Running setup.py (path:/tmp/pip-ibB54q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:31 INFO - Running setup.py (path:/tmp/pip-FSXp_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:31 INFO - Running setup.py (path:/tmp/pip-H1IMyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:31 INFO - Running setup.py (path:/tmp/pip-LgSrU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:31 INFO - Running setup.py (path:/tmp/pip-7cEbH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:31 INFO - Running setup.py (path:/tmp/pip-TOtmrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:31 INFO - Running setup.py (path:/tmp/pip-pOtovT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:31 INFO - Running setup.py (path:/tmp/pip-6rj684-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:32 INFO - Running setup.py (path:/tmp/pip-PEx_9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:02:32 INFO - Running setup.py install for manifestparser 20:02:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Running setup.py install for mozcrash 20:02:32 INFO - Running setup.py install for mozdebug 20:02:32 INFO - Running setup.py install for mozdevice 20:02:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Running setup.py install for mozfile 20:02:32 INFO - Running setup.py install for mozhttpd 20:02:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Running setup.py install for mozinfo 20:02:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Running setup.py install for mozInstall 20:02:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:02:32 INFO - Running setup.py install for mozleak 20:02:32 INFO - Running setup.py install for mozlog 20:02:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Running setup.py install for moznetwork 20:02:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Running setup.py install for mozprocess 20:02:33 INFO - Running setup.py install for mozprofile 20:02:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Running setup.py install for mozrunner 20:02:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Running setup.py install for mozscreenshot 20:02:33 INFO - Running setup.py install for moztest 20:02:33 INFO - Running setup.py install for mozversion 20:02:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:02:33 INFO - Cleaning up... 20:02:33 INFO - Return code: 0 20:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:33 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')]} 20:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:33 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')]} 20:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:33 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:33 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 20:02:33 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 20:02:33 INFO - Using env: {'DISPLAY': ':0', 20:02:33 INFO - 'HOME': '/home/cltbld', 20:02:33 INFO - 'LANG': 'en_US.UTF-8', 20:02:33 INFO - 'LANGUAGE': 'en_US:en', 20:02:33 INFO - 'LOGNAME': 'cltbld', 20:02:33 INFO - 'MAIL': '/var/mail/cltbld', 20:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:33 INFO - 'MOZ_NO_REMOTE': '1', 20:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:33 INFO - 'NO_EM_RESTART': '1', 20:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:33 INFO - 'PWD': '/builds/slave/test', 20:02:33 INFO - 'SHELL': '/bin/bash', 20:02:33 INFO - 'SHLVL': '1', 20:02:33 INFO - 'TERM': 'linux', 20:02:33 INFO - 'TMOUT': '86400', 20:02:33 INFO - 'USER': 'cltbld', 20:02:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:33 INFO - '_': '/tools/buildbot/bin/python'} 20:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:34 INFO - Running setup.py (path:/tmp/pip-b_uuv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:34 INFO - Running setup.py (path:/tmp/pip-V19Pqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:34 INFO - Running setup.py (path:/tmp/pip-1SLD17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:34 INFO - Running setup.py (path:/tmp/pip-2aPn6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:34 INFO - Running setup.py (path:/tmp/pip-aHD9bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:34 INFO - Running setup.py (path:/tmp/pip-3Esk9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:34 INFO - Running setup.py (path:/tmp/pip-bcpCgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:34 INFO - Running setup.py (path:/tmp/pip-f4Iul3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:34 INFO - Running setup.py (path:/tmp/pip-Mu1h0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:34 INFO - Running setup.py (path:/tmp/pip-cLAGCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:34 INFO - Running setup.py (path:/tmp/pip-g8FaMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:34 INFO - Running setup.py (path:/tmp/pip-fYpdZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:34 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)) 20:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:35 INFO - Running setup.py (path:/tmp/pip-o9JOuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:35 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)) 20:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:35 INFO - Running setup.py (path:/tmp/pip-TsWO5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:35 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)) 20:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:35 INFO - Running setup.py (path:/tmp/pip-NL9Cnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:35 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)) 20:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:35 INFO - Running setup.py (path:/tmp/pip-kz0rjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:35 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)) 20:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:35 INFO - Running setup.py (path:/tmp/pip-05_9NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:35 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)) 20:02:35 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)) 20:02:35 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)) 20:02:35 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)) 20:02:35 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)) 20:02:35 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)) 20:02:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:02:35 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 20:02:35 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 20:02:35 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 20:02:35 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 20:02:35 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 20:02:35 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 20:02:37 INFO - Downloading blessings-1.6.tar.gz 20:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:02:37 INFO - Installing collected packages: blessings 20:02:37 INFO - Running setup.py install for blessings 20:02:37 INFO - Successfully installed blessings 20:02:37 INFO - Cleaning up... 20:02:37 INFO - Return code: 0 20:02:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:37 INFO - Reading from file tmpfile_stdout 20:02:37 INFO - Current package versions: 20:02:37 INFO - argparse == 1.2.1 20:02:37 INFO - blessings == 1.6 20:02:37 INFO - blobuploader == 1.2.4 20:02:37 INFO - docopt == 0.6.1 20:02:37 INFO - functools32 == 3.2.3-2 20:02:37 INFO - jsonschema == 2.5.1 20:02:37 INFO - manifestparser == 1.1 20:02:37 INFO - mozInstall == 1.12 20:02:37 INFO - mozcrash == 0.17 20:02:37 INFO - mozdebug == 0.1 20:02:37 INFO - mozdevice == 0.48 20:02:37 INFO - mozfile == 1.2 20:02:37 INFO - mozhttpd == 0.7 20:02:37 INFO - mozinfo == 0.9 20:02:37 INFO - mozleak == 0.1 20:02:37 INFO - mozlog == 3.4 20:02:37 INFO - moznetwork == 0.27 20:02:37 INFO - mozprocess == 0.23 20:02:37 INFO - mozprofile == 0.28 20:02:37 INFO - mozrunner == 6.12 20:02:37 INFO - mozscreenshot == 0.1 20:02:37 INFO - mozsystemmonitor == 0.3 20:02:37 INFO - moztest == 0.7 20:02:37 INFO - mozversion == 1.4 20:02:37 INFO - psutil == 3.1.1 20:02:37 INFO - requests == 1.2.3 20:02:37 INFO - wsgiref == 0.1.2 20:02:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02: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')]} 20:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02: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')]} 20:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:37 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:37 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 20:02:37 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 20:02:37 INFO - Using env: {'DISPLAY': ':0', 20:02:37 INFO - 'HOME': '/home/cltbld', 20:02:37 INFO - 'LANG': 'en_US.UTF-8', 20:02:37 INFO - 'LANGUAGE': 'en_US:en', 20:02:37 INFO - 'LOGNAME': 'cltbld', 20:02:37 INFO - 'MAIL': '/var/mail/cltbld', 20:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:37 INFO - 'MOZ_NO_REMOTE': '1', 20:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:37 INFO - 'NO_EM_RESTART': '1', 20:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:37 INFO - 'PWD': '/builds/slave/test', 20:02:37 INFO - 'SHELL': '/bin/bash', 20:02:37 INFO - 'SHLVL': '1', 20:02:37 INFO - 'TERM': 'linux', 20:02:37 INFO - 'TMOUT': '86400', 20:02:37 INFO - 'USER': 'cltbld', 20:02:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:37 INFO - '_': '/tools/buildbot/bin/python'} 20:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 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)) 20:02:37 INFO - Cleaning up... 20:02:37 INFO - Return code: 0 20:02:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:02: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')]} 20:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02: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')]} 20:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:37 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 0x7f885298ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2023ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', '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 20:02:37 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 20:02:37 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 20:02:37 INFO - Using env: {'DISPLAY': ':0', 20:02:37 INFO - 'HOME': '/home/cltbld', 20:02:37 INFO - 'LANG': 'en_US.UTF-8', 20:02:37 INFO - 'LANGUAGE': 'en_US:en', 20:02:37 INFO - 'LOGNAME': 'cltbld', 20:02:37 INFO - 'MAIL': '/var/mail/cltbld', 20:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:37 INFO - 'MOZ_NO_REMOTE': '1', 20:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:37 INFO - 'NO_EM_RESTART': '1', 20:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:37 INFO - 'PWD': '/builds/slave/test', 20:02:37 INFO - 'SHELL': '/bin/bash', 20:02:37 INFO - 'SHLVL': '1', 20:02:37 INFO - 'TERM': 'linux', 20:02:37 INFO - 'TMOUT': '86400', 20:02:37 INFO - 'USER': 'cltbld', 20:02:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:37 INFO - '_': '/tools/buildbot/bin/python'} 20:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:02:38 INFO - Cleaning up... 20:02:38 INFO - Return code: 0 20:02:38 INFO - Running post-action listener: _resource_record_post_action 20:02:38 INFO - Running post-action listener: _start_resource_monitoring 20:02:38 INFO - Starting resource monitoring. 20:02:38 INFO - [mozharness: 2016-10-27 03:02:38.244145Z] Finished create-virtualenv step (success) 20:02:38 INFO - [mozharness: 2016-10-27 03:02:38.244613Z] Running install step. 20:02:38 INFO - Running pre-action listener: _resource_record_pre_action 20:02:38 INFO - Running main action method: install 20:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:38 INFO - Reading from file tmpfile_stdout 20:02:38 INFO - Detecting whether we're running mozinstall >=1.0... 20:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:02:38 INFO - Reading from file tmpfile_stdout 20:02:38 INFO - Output received: 20:02:38 INFO - Usage: mozinstall [options] installer 20:02:38 INFO - Options: 20:02:38 INFO - -h, --help show this help message and exit 20:02:38 INFO - -d DEST, --destination=DEST 20:02:38 INFO - Directory to install application into. [default: 20:02:38 INFO - "/builds/slave/test"] 20:02:38 INFO - --app=APP Application being installed. [default: firefox] 20:02:38 INFO - mkdir: /builds/slave/test/build/application 20:02:38 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'] 20:02:38 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 20:02:54 INFO - Reading from file tmpfile_stdout 20:02:54 INFO - Output received: 20:02:54 INFO - /builds/slave/test/build/application/firefox/firefox 20:02:54 INFO - Running post-action listener: _resource_record_post_action 20:02:54 INFO - [mozharness: 2016-10-27 03:02:54.807817Z] Finished install step (success) 20:02:54 INFO - [mozharness: 2016-10-27 03:02:54.808060Z] Running run-tests step. 20:02:54 INFO - Running pre-action listener: _resource_record_pre_action 20:02:54 INFO - Running main action method: run_tests 20:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:54 INFO - Python 2.7.3 20:02:54 INFO - Return code: 0 20:02:54 INFO - grabbing minidump binary from tooltool 20:02: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')]} 20:02:54 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 0x2020f60>, '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 0x2021d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20221d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:54 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 20:02:54 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 20:02:54 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 20:02:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:54 INFO - Return code: 0 20:02:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:02:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:02:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 20:02:54 INFO - Using env: {'DISPLAY': ':0', 20:02:54 INFO - 'HOME': '/home/cltbld', 20:02:54 INFO - 'LANG': 'en_US.UTF-8', 20:02:54 INFO - 'LANGUAGE': 'en_US:en', 20:02:54 INFO - 'LOGNAME': 'cltbld', 20:02:54 INFO - 'MAIL': '/var/mail/cltbld', 20:02:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:54 INFO - 'MOZ_NO_REMOTE': '1', 20:02:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:54 INFO - 'NO_EM_RESTART': '1', 20:02:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:54 INFO - 'PWD': '/builds/slave/test', 20:02:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:54 INFO - 'SHELL': '/bin/bash', 20:02:54 INFO - 'SHLVL': '1', 20:02:54 INFO - 'TERM': 'linux', 20:02:54 INFO - 'TMOUT': '86400', 20:02:54 INFO - 'USER': 'cltbld', 20:02:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354', 20:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:54 INFO - '_': '/tools/buildbot/bin/python'} 20:02:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:02:55 INFO - mozversion application_buildid: 20161026183135 20:02:55 INFO - mozversion application_changeset: 54f7bdea89765bb113513f00000160f4dd25c317 20:02:55 INFO - mozversion application_display_name: Nightly 20:02:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:55 INFO - mozversion application_name: Firefox 20:02:55 INFO - mozversion application_remotingname: firefox 20:02:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:02:55 INFO - mozversion application_vendor: Mozilla 20:02:55 INFO - mozversion application_version: 52.0a1 20:02:55 INFO - mozversion platform_buildid: 20161026183135 20:02:55 INFO - mozversion platform_changeset: 54f7bdea89765bb113513f00000160f4dd25c317 20:02:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:02:55 INFO - mozversion platform_version: 52.0a1 20:02:55 INFO - using testdate: 1477537375 20:02:55 INFO - actual date: 1477537375 20:02:55 INFO - starting webserver on 'localhost:51588' 20:02:55 INFO - SUITE-START | Running 2 tests 20:02:55 INFO - TEST-START | dromaeo_css 20:02:55 INFO - operating with platform_type : linux_ 20:02:55 INFO - Initialising browser for dromaeo_css test... 20:02:55 INFO - TEST-INFO | started process 4321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ9qyCO/profile http://localhost:51588/getInfo.html) 20:02:59 INFO - PROCESS | 4321 | __metrics Screen width/height:1600/1200 20:02:59 INFO - PROCESS | 4321 | colorDepth:24 20:02:59 INFO - PROCESS | 4321 | Browser inner width/height: 1024/697 20:02:59 INFO - PROCESS | 4321 | __metrics 20:02:59 INFO - PROCESS | 4321 | 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" 20:02:59 INFO - PROCESS | 4321 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:03:00 INFO - PROCESS | 4321 | console.error: PushService: 20:03:00 INFO - PROCESS | 4321 | stateChangeProcessEnqueue: Error transitioning state 20:03:00 INFO - PROCESS | 4321 | UnknownError 20:03:01 INFO - TEST-INFO | 4321: exit 0 20:03:01 INFO - Browser initialized. 20:03:01 INFO - Running cycle 1/1 for dromaeo_css test... 20:03:01 INFO - TEST-INFO | started process 4404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ9qyCO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:13 INFO - PROCESS | 4404 | RSS: Main: 173199360 20:03:13 INFO - PROCESS | 4404 | 20:04:04 INFO - PROCESS | 4404 | 1477537444531 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] 20:06:16 INFO - PROCESS | 4404 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51588/tests/dromaeo/cssquery-ext.html) 20:06:19 INFO - PROCESS | 4404 | RSS: Main: 438943744 20:06:19 INFO - PROCESS | 4404 | 20:09:22 INFO - PROCESS | 4404 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-ext.html (next: http://localhost:51588/tests/dromaeo/cssquery-jquery.html) 20:09:23 INFO - PROCESS | 4404 | RSS: Main: 285237248 20:09:23 INFO - PROCESS | 4404 | 20:12:25 INFO - PROCESS | 4404 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51588/tests/dromaeo/cssquery-mootools.html) 20:12:26 INFO - PROCESS | 4404 | RSS: Main: 221048832 20:12:26 INFO - PROCESS | 4404 | 20:15:28 INFO - PROCESS | 4404 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51588/tests/dromaeo/cssquery-prototype.html) 20:15:29 INFO - PROCESS | 4404 | RSS: Main: 219967488 20:15:29 INFO - PROCESS | 4404 | 20:18:32 INFO - PROCESS | 4404 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51588/tests/dromaeo/cssquery-yui.html) 20:18:32 INFO - PROCESS | 4404 | RSS: Main: 219901952 20:18:32 INFO - PROCESS | 4404 | 20:21:35 INFO - PROCESS | 4404 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-yui.html (next: http://localhost:51588/tests/dromaeo/cssquery-dojo.html) 20:21:36 INFO - PROCESS | 4404 | RSS: Main: 308240384 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | __start_tp_report 20:21:36 INFO - PROCESS | 4404 | _x_x_mozilla_page_load 20:21:36 INFO - PROCESS | 4404 | _x_x_mozilla_page_load_details 20:21:36 INFO - PROCESS | 4404 | |i|pagename|runs| 20:21:36 INFO - PROCESS | 4404 | |0;dojo.html;2500.862452565109;2517.244826552034;2545.363659085228;2553.7956963442925;2568.242368501292;4396.340548917664;4459.375687403766;4512.5713057259545;4545.272756358979;4555.316702494623;4462.464504259493;4479.955200447995;4493.393391892102;4495;4496.730196188231;4123.443335149746;4143.109231515224;4154.688398370119;4155.31437312843;4181.540030596632;4143.19207754488;4156.023334516386;4178.853740119096;4224.155168966219;4237.131388065454;4277.294246449332;4288.6140247377725;4289.892752681192;4299.355096735483;4306.031142992832;4284.850030248957;4289.849855255051;4292.785360731951;4308.073764140725;4328.329108988112;4063.2482990646827;4120.114175452262;4120.278951183531;4200.1179752252065;4253.702240843142;4405.3612226227015;4573.062522182944;4573.565511276457;4604.5165257647795;4628;4849.369581954358;4855.344528488679;4857.708537487762;4858.441279252896;4916.311716359713;4726.456457507396;4787.234042553209;4790.305405716186;4831.371921650163;4879.463259041502;4437.400950871655;4458.7547684877645;4459.420275364214;4494.842680506166;4539.092181563635;4881.219004959189;4909.582685471703;4913.164761990471;4918.729469879119;4972.975135124301;4601.401817763669;4700.694454860423;4701.600363969101;4706.670533062653;4763.214069678534;4735.2186889163595;4786.928196077061;4788.11419887322;4828.686135401188;4849.393825771778;4810.903781924342;4820.276958456259;4826.32431459596;4867.659263851497;4876.780544875489;4798.95201047985;4808.2787581863;4810.831620893322;4815.15734746418;4872.19608764557;3766.924661506809;3774.2828862516585;3813.275477659236;3815.4086116651406;3835.7890316032326;3364.9327013459592;3367.562216911786;3410.6077801053198;3419.760616756853;3432.485127230935;4135.5864413559;4140.772257525805;4147.8963025924595;4150.896227594334;4196.391523229176;4662.743549104764;4719.2921061841;4804.375431193923;4804.95195048045;4851.320815085891;4081.6938729594804;4106.384042393605;4119;4120.237756015147;4120.855770048034;4251.532331443539;4256.616904478612;4287.699861009762;4305.268104422255;4319.33050377192;4552.271636538138;4594.724316541018;4611.861644150681;4648.86053418398;4650.883727906829;4881.487443818348;4885.047415753894;4886.340344053508;4927.433345165208;4950.777215025405;4586;4590.540945905383;4595.885102872455;4598;4653.650976176733;4598.333241679871;4738.099761045391;4739.952600473951;4795.832145875017;4799.688020278811;4831.855044348676;4846.854594362175;4873.098476781806;4877.219644856806;4877.341558889504;4730.952690473051;4743.881402964954;4748.169070412733;4751.548602882721;4752.168370535073;4733.7396443194575;4748.358971538798;4753.405824271966;4754.381930349033;4759.3336932830125;4656.1851675955895;4670.509596492319;4677.391939047902;4684.7891844867745;4689.695169813951;4732.716037037651;4738.312944622941;4753.429588449409;4754.97622511899;4763.54746299101;4625.051864367864;4629.583337499641;4636.420447444069;4637.60580350674;4670.953290467051 20:21:36 INFO - PROCESS | 4404 | |1;ext.html;552.2516989479253;559.6110703061372;573.4065242474039;575.0569066730562;581.5551103405897;27779.16662500123;36957;38624.80687596565;38673;42569.14861702764;39809.800950995275;40266.19467610646;40288.395674064916;40300.798496007556;40334.59665403345;7703.46075774696;7834.804129896741;7835.608219588998;7842.843143137163;7845.372370210398;7406.8888966665545;7547.132079810837;9823.165030972375;10146.695599132001;10152.796944061114;10193.082622563968;10251.436171010591;10255.897441025607;10260.127889129433;10266;9973.052560006823;10028.498575071217;10038.247131465096;10039.698809035704;10041.949790251001;9977.002299770038;10044.748881277954;10045.69862904114;10050.145737612313;10055.446950417723;37301;37509.62490375089;37551.624483755084;37572.24855502902;37704.24591508154;2959.5856580078807;3181.602299712536;3191.377681352137;3292.818894960776;3357.1607098225445;27866.721332786616;28455.57316640252;28669.713302866912;29219.56170657442;29820.552691709643;3214.0839860639608;3226.790258633181;3260.0871755908383;3297.8351082445784;3353.564036675241;238057.99999999825;238821;239083;239326;239600;31392;32236.516452253236;52719.47280527222;52964.470355295955;53139.46860531423;31122.844385777928;31336.21659458532;31385.686143138733;31406.685933140376;31436.842815785774;13391.464341426234;13533.593992180053;13542.052056356157;13545.796813047813;13548.796768048487;9760.95119524412;10131.392116472887;10149.289549731595;10163.034511721522;10243.436610986468;7247.094113235846;7293.854122917512;7296.051513303343;7498.812529686801;7711.652975616111;3002.8048176868433;3021.969780302169;3026.576279320897;3046.558249053875;3051.5575241589845;820.6184124382191;876.2639382918379;901.535709109809;938.9154976052188;967.6613185385058;26397.472050559267;27888;27935.89858940925;28042.579361309596;28434.85782571074;936.784539555906;958.2142643032786;962.4802606592361;970.3256236915277;979.6913972098766;13980.790288145687;14744;14989.250537473301;15202.771958420633;15278.541643750705;395165;401095;401325;401405;622559;42470.575294246664;54583.72708136434;56319;56598.43401565932;56615.71692141595;1170.3913964738288;1189.4052973513071;1195.2410219510673;1223.0949097667483;1226.7975783995719;27540.173794786187;28368.71631283661;28876.27809304784;29236;29490.852545737132;42372.15255694807;43437.96397666442;43455.34816977811;43458.56541434545;43480.34779478374;331782;331897.83174934227;332107;332908;333389;24513;24633.38416539529;24997.500049998533;25037.374065648506;25105.49789004173;40540;40808.79595602003;41100.79449602733;41262.1747565053;41511;34511.4823277656;35049.299014020085;35186.47220291646;35271.294574108884;35477;34492.82753586216;34661.65338346685;34857.825710871286;35234.8238258807;35337.116572085906;34439.65560344364;34522.82738586291;34649.48025779565;35016.82491587526;35239.11902202466;29322;32014.35971280608;32096.679033210305;32253.51619725659;32277.838610806797;24606.753932460448;24733.381665458506;24794;25048.248552543453;25076.373090672878 20:21:36 INFO - PROCESS | 4404 | |2;jquery.html;334.0812764896535;344.6897791987213;352.3815703440462;356.76988342519076;383.72755343705967;12203.755924881498;15729.606759830996;15785.763213551792;16808.075555844425;16932.492025239233;15706.607334816636;16028.75956860648;16029.679406411893;16338.937969032004;16429.83570164298;4963.751812409383;4976.178930476467;5111.207762796754;5170.819021334254;5218.686878787266;5060.873478163038;5116.820911268106;5135.948640513584;5239.554637855767;5571.0807716726695;5631.859203519924;5632.986062508747;5637;5640.746166422521;5641.633293835908;5391.541718953894;5566.777328906839;5600.635958662674;5623.0721930881355;5627.184058311563;5428.538574221196;5434.130539113723;5438.564914806806;5439.156930675752;5439.891202175974;12397.132200745951;18902.975523916106;19636.70544941827;19745.111469983884;20822.271220507362;1710.6407654392592;1781.2251670523235;1949.2982526290525;2076.844236682255;2186.9830528804023;8995.460272383678;9102.77243068922;9269.39748916325;9382.620012865184;9765.90234097657;1622.2375483522726;1633.7794397756388;1639.1066868556666;1682.1757338903972;1745.1884873533868;62319.37680623226;62350.68824655938;68087;69022;71410;9622.422654640744;9659.164758695826;9762.682037924931;9803.803923921625;9983.356075032561;13853.099548529313;13866.930665346608;13869;13875.930620346833;13890.652733681738;7124.964375178091;7375.741849035366;7522.774316770506;7573.863920411983;7630.618469076635;6545.607263564201;6715.899261511081;6783.55906866062;7039.190493093258;7048.612326321999;4152.750834949913;4239.321708526621;4303.462067241595;4357.455318085239;4371.78141092944;1757.244384914499;1761.7621621081246;1762.1805860274778;1810.9456716298532;1815.137809540484;793.8452001859697;859.0764927702744;861.2507118806678;897.3852910756153;912.5802131019806;16155.515334539983;16661.083640399895;16760.664786704197;16773.7483937741;17507.47477575675;808.3654331349979;815.2133191470259;837.7612380471659;855.3798496090285;857.1942374168262;8885.133455937199;9407.905920940702;9549.761255968657;9628;9660.855087173699;345146;349649;352634;354047;355976;44190;51004.74497627488;77684.61157694175;79579;85302.57348713341;402.66981075517793;422.78437996621943;424.4778921926048;424.5966331984627;425.97870106494554;9745.707628771148;9793.265505087289;9860.16188623975;9888.950555247178;10272.948635256776;24951.376215594755;26501.734982650698;30494.84752576223;33795.32409351848;35606.82196589104;46073;47510;49575.50424495709;49985;50468;7230.89153662706;7255.709771609288;7519.398448124028;7596.392288616787;7624.313811756747;8158.510489370657;10156.39061656303;11675.649730508097;11716.472758726048;12434.937825310815;10196.490175491344;10204.2346823987;10314.793704125725;10388.220883433622;10457.11114555241;9264.980852106128;9397.060293970822;10048.84926726085;10384.42885641297;10444.947775261075;10007.549660265451;10053.597856085968;10323.432211228455;10364.844527332247;10867.347959122479;7381.335679788845;7429.257074292527;7533.434992375484;7576.356009739234;7585.9379686842785;10237.181025517792;10316.43259620728;10352.223583231138;10760.515776789907;10890.128789696964 20:21:36 INFO - PROCESS | 4404 | |3;mootools.html;1208.3595694282023;1318.61760089574;1389.6873203529206;1417.1922004457456;1676.3732099405636;5961.403859614036;6572.342765723425;6678.866422671544;6679.532432729705;6852.246252912176;6742.325767423267;6854.348836860503;6871.931280687191;7011.544249623784;7024.0166376707175;2037.898105094743;2098.244631932503;2100.170432679091;2101.023024293703;2101.138533201388;2078.347585376564;2123.8088572028514;2131.6269652810697;2133.5946170227685;2134.3703607435764;2064.1846470644164;2069.306782227948;2086.383053133818;2088.3212955789354;2096.360610013945;2010.7687615924137;2023.261509549004;2028.5537181819975;2030.5634288627941;2031.238285642884;1975;1988.8309493693052;2011.5574573593785;2017.0923084611984;2020.5049762808205;7096.467764917652;7174.0315057467615;7202.747903823393;7215.819604509877;7226.674799634029;4208.516020657633;4325.978370108161;4336.197803406349;4336.956630433687;4337.154254920292;2524.2679622909336;2730.5221586222333;2777.264025033368;2791.8553393108728;2797.804153709221;853.5732133933034;865.5931712095305;868.913108689126;1673.548142001665;1719;9341.579628916646;9496.097870702271;9541.666041688577;9559.235261179088;9581.520923953844;3720.330340538675;3791.33651610967;3815.465834783133;3879.1465877506903;3887.747296425723;8189.590520473953;8195.303399211014;8197;8197.71308004229;8208.876866847002;4306.4832220133785;4306.784660766949;4308.418363520885;4318.5681431856565;4325.43769309994;3486.4944583035317;3581.71346292296;3585.1754096557415;3926.6662333701956;4019.2966230909474;3053.587765651653;3365.865365385406;3375.8818441354433;3385.5768028996376;3398.575178102737;1083.1767856429171;1130.8812574679541;1143.3997151495532;1149.0864762513822;1151.2459339132881;775.83707421441;786.6813940354166;793.4644115222202;812.0864027968536;813.6297984417076;4687.742174180453;4729.219678752967;4749.810007599657;4782.163121453801;4904.2643603459765;371.48178291283506;371.88471573812205;388.37277796358677;389.24098008882794;390.8280356643068;3193.297474555594;3249.675032496779;3259.152620318687;3282.7537934654997;3355.3624811286268;7840.725574604861;7997.8400431992195;8103.270705636521;8206.794830129294;8264.710735124241;8127.959360203161;8177.386695997824;8189.426740128253;8199.262066413932;8204.794880128045;6376;6392.648404337806;6409.359064093554;6479.254885688112;6479.319671434526;4427.693830320128;4480.924578101298;4538.1377538267625;4551.931721024253;4698.130845793539;7370.44721645868;7605.961970190114;7734.6132693366235;7769.300762931363;7782.883256751266;8135.145809689898;8145.348372130334;8153.6330865112395;8179;8257.42198046131;6016.759329626941;6155.907661384993;6163.7842675506145;6164.876702466016;6167;6809.829754256183;6909.067275917687;6960.338767817049;6961.6519174042105;6967.2684368142645;6188.164597779242;6295.18162638854;6324.051392291193;6332.588381755171;6365.490760739037;6256.124142620128;6325.335839736761;6356.3325850785;6388.648624325707;6410;5734.254546908875;5758.683272419889;5778.624389414675;6066.15073889647;6130.141780150871;4025.6779457642733;4099.159672267118;4111.239420707178;4131.235721391552;4407.316865885793;4336.262835317941;4354.673399494987;4401.471823381215;4472.731636101845;4489.0572979674635 20:21:36 INFO - PROCESS | 4404 | |4;prototype.html;288.1298478594644;291.66604238147323;291.74472336705384;295.1646839444373;300.3947046700898;4669.34629151919;4783.689060211088;4815.351556643849;4835.395575553056;4848.806047758086;4730.763461826903;4758.952410475894;4761.000759362135;4762.9285560716535;4764.666473346859;3540.8583656653705;3543.0256679413237;3622.492851000849;3679.871204507843;3685.4287585424167;3646.781193128421;3648.963510364902;3659.6706296433317;3665.6437118266144;3668.266346730651;3619.511365965587;3626.9455958160647;3628.5282913221245;3631.2737452509473;3647.379945409287;3484.6409900138965;3555.3600351936643;3585.713142948558;3621.257642183346;3631.854725810951;3222.6455089940087;3225.4194245035883;3227.3706627207703;3234.2884565395575;3240.2061494933655;4597.850537365659;4598.816047358102;4606.309053641947;4608.33179189019;4616.215243408628;4174.499060112776;4177.143685544456;4180.561041090703;4186.748795072305;4221.767802770846;4656.32483289921;4884.462709101996;4915.975420122876;4918.557329840296;4922.606191504707;3497.2480916603054;3504.088936876405;3506.386382383073;3506.4915587239707;3529.5588051493564;5189.221616757479;5190.273361729361;5214.113600687854;5218.66078704883;5227.503387178212;3502.2820321833965;3549.6095429502734;3564.3049605326714;3584.7669901456843;3598.676119149289;3609.787289312514;3618.620044895301;3618.873339433107;3628.4375921732176;3639.1993761372455;4154.875353739392;4170.4995400552125;4194.496660400771;4198.538160802309;4220.978895105566;4757.643176761757;4954.256861470808;4982.975085124624;4998.100341938413;5044.9495505045215;1197.6766273106211;1219.6280134559045;1220.261741646309;1223.9938800305943;1226.8037114061708;778.0585491555281;778.8208711996273;800.519688187083;805.0379796143552;807.6648191000669;3948.6505529210076;3952.8023598819946;4174.83300667976;4251.681978586648;4319.719218250866;5100.285959965608;5110.540051395392;5115.444765887747;5125.2568377585785;5133.666311689728;4392.879815646989;4396.1867054595;4402.273624851928;4408.448943882015;4411.382406463098;2581.1802679111183;2676.8661566921965;2684.1276585109918;2700.51390749663;2707.4991126641635;4777.713337199779;4793.712377257376;4802.375691160127;4816.229403295456;4821.397325334333;5191.896162076738;5194.27280180775;5195.428502864682;5198.428172900978;5215.374155101412;4581.106684196549;4800.66395352329;4827.782749776268;4838.846628340876;4859.586935110555;5145.459726728789;5147.124988751996;5151.6908985461;5155.664881782672;5163.690178589297;5051.494850514919;5080.771365288497;5088.753255452438;5089.185730283137;5090.949090509195;4667.113248482778;4830.734309613005;4840.564349208447;4845.127876982177;4881.658283920092;3569.411047177187;3578.0697018774786;3583.51622530955;3588.1209103769743;3589.443636236283;5126.590187698413;5133;5145.974270128625;5160.896782064263;5168.405633352213;4786.234202527578;4931.161702510653;4947.6536642434685;4975.850724478271;5002.199648056294;4972.3038774572315;4976.32819569368;4980.900381992412;4993.726599717049;4996.425411077773;4921.114199444134;4921.926171107508;4933.851984440473;4949.57928576075;4949.851504454872;4742.857714268577;4793.640476964172;4978.30303757467;5034.917492739079;5047.318611987334;4740.502247263988;4776.8566942991765;4898.583620392306;4909.140900342354;4912.729799860899 20:21:36 INFO - PROCESS | 4404 | |5;yui.html;628.4281304013349;645.245063275967;673.8012286375518;683.6718375179913;715.0668377767014;12092.637220883376;12729;12771.106022578424;12832;12839.743205135892;11893.52425902963;11998.040156787436;12017.639470815868;12026.458809353579;12033.518659253641;618.9783357582486;638.8977763557832;644.3105876711896;774.9418793590476;797.5972134072285;629.735511085343;630.0675000998525;769.3537428560008;791.7387262203488;804.7625950344662;806.238104990781;808.4744915804715;808.5835794565803;808.7169490678274;811.168552233959;640.4300172846171;804.3123129724119;804.9879251811227;805.3275514945028;809.6963638635511;485.83967290793953;582.2401765695765;599.241958921964;599.5922772514688;604.4348534120611;12840.807387889188;12849.100562960597;12864.163829351062;12877.67805804853;12882;10091.747706307327;10196.439195844225;10271.6404925828;10440.269181157322;10592.62925797601;10337.379757214516;10535.789284214272;10615.097716694014;10672.03951644348;10673.668402182113;3625.093726568358;3641.308151451216;3646.1431563582537;3659.1949771050326;3718.9814050929845;47716;49381.50618493841;49881.750591247175;50032.49967500315;50392.24411633828;8482.194191551793;8898.11018898105;8904.421212621159;8979.685711000215;8985.502924761302;15768;15780.368785248691;15783.526494205193;15811;15959.202039897958;6069.302030266487;6159.969200153971;6164.599301045418;6214.1921550198185;6351.936480635227;3368.545246391755;3393.4570468724887;3407.9659203408146;3470.913227169341;3557.768745031565;2445.792107670868;2544.75824796644;2550.09471637566;2551.553478141318;2564.423004823937;462.7686156921539;468.06153661908337;468.6859803931374;469.3546373736113;473.02556733129865;505.76734702036737;508.6236185222908;528.0785030122461;547.5920439272767;559.8600349912522;7140.642967851691;7144.821379465555;7242.674079666428;7256.8911466328045;7322.340989310987;494.4659767451144;529.9046171689056;537.5081800152894;565.6945249565189;588.2411688921244;3630.110622897407;3676.3750162472443;3720.330340538729;3760.8495660173835;3792.27946690128;56005;57260;58569.12146317809;59324;70718.64640676764;55597.888042239734;56084.71957640268;57109.42890571124;58639;59208.7039564808;52020.479795201565;52367.73816130971;52611.210831837554;52617.47382526202;55657.72171139118;8014.919850801417;8394.37042221848;8444.215712237137;8544.273736732448;8695.826083478421;35275;35809.64190358167;36279.83703666654;36695.449568257034;36734.44898326474;32356.191095222806;32574.348513029134;33483;38752.418713718755;43155.568444315155;8533.189347012023;8688.52213128284;10542.15662746963;10834;11016.283941543774;9959.502024898871;10030.247731420319;10514.158867290751;11735.589254376056;12023.158378913393;11085.667429977113;11308.264962777394;11465.426728663366;11711.648650540497;12023.63929082129;11241.325520468798;11494.367809770543;11555.711107222387;12484.375781211085;12487.500499980262;10681.252312338062;10694;10931.617393391192;11198.04816590599;11234.213605047895;9107.22588579978;9455.810106526005;9466.05339466048;9687.612495500101;9765;9759.12167904892;9988.400695957975;10137.239707021856;10167.288289819937;10180.898191018292 20:21:36 INFO - PROCESS | 4404 | __end_tp_report 20:21:36 INFO - PROCESS | 4404 | __start_cc_report 20:21:36 INFO - PROCESS | 4404 | _x_x_mozilla_cycle_collect,3112 20:21:36 INFO - PROCESS | 4404 | __end_cc_report 20:21:36 INFO - PROCESS | 4404 | __startTimestamp1477538496130__endTimestamp 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | ------- Summary: start ------- 20:21:36 INFO - PROCESS | 4404 | Number of tests: 6 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | [#0] dojo.html Cycles:165 Average:4459.79 Median:4611.86 stddev:485.12 (10.5%) stddev-sans-first:461.62 20:21:36 INFO - PROCESS | 4404 | Values: 2500.9 2517.2 2545.4 2553.8 2568.2 4396.3 4459.4 4512.6 4545.3 4555.3 4462.5 4480.0 4493.4 4495.0 4496.7 4123.4 4143.1 4154.7 4155.3 4181.5 4143.2 4156.0 4178.9 4224.2 4237.1 4277.3 4288.6 4289.9 4299.4 4306.0 4284.9 4289.8 4292.8 4308.1 4328.3 4063.2 4120.1 4120.3 4200.1 4253.7 4405.4 4573.1 4573.6 4604.5 4628.0 4849.4 4855.3 4857.7 4858.4 4916.3 4726.5 4787.2 4790.3 4831.4 4879.5 4437.4 4458.8 4459.4 4494.8 4539.1 4881.2 4909.6 4913.2 4918.7 4973.0 4601.4 4700.7 4701.6 4706.7 4763.2 4735.2 4786.9 4788.1 4828.7 4849.4 4810.9 4820.3 4826.3 4867.7 4876.8 4799.0 4808.3 4810.8 4815.2 4872.2 3766.9 3774.3 3813.3 3815.4 3835.8 3364.9 3367.6 3410.6 3419.8 3432.5 4135.6 4140.8 4147.9 4150.9 4196.4 4662.7 4719.3 4804.4 4805.0 4851.3 4081.7 4106.4 4119.0 4120.2 4120.9 4251.5 4256.6 4287.7 4305.3 4319.3 4552.3 4594.7 4611.9 4648.9 4650.9 4881.5 4885.0 4886.3 4927.4 4950.8 4586.0 4590.5 4595.9 4598.0 4653.7 4598.3 4738.1 4740.0 4795.8 4799.7 4831.9 4846.9 4873.1 4877.2 4877.3 4731.0 4743.9 4748.2 4751.5 4752.2 4733.7 4748.4 4753.4 4754.4 4759.3 4656.2 4670.5 4677.4 4684.8 4689.7 4732.7 4738.3 4753.4 4755.0 4763.5 4625.1 4629.6 4636.4 4637.6 4671.0 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | [#1] ext.html Cycles:180 Average:47812.08 Median:331839.92 stddev:93645.54 (28.2%) stddev-sans-first:93841.02 20:21:36 INFO - PROCESS | 4404 | Values: 552.3 559.6 573.4 575.1 581.6 27779.2 36957.0 38624.8 38673.0 42569.1 39809.8 40266.2 40288.4 40300.8 40334.6 7703.5 7834.8 7835.6 7842.8 7845.4 7406.9 7547.1 9823.2 10146.7 10152.8 10193.1 10251.4 10255.9 10260.1 10266.0 9973.1 10028.5 10038.2 10039.7 10041.9 9977.0 10044.7 10045.7 10050.1 10055.4 37301.0 37509.6 37551.6 37572.2 37704.2 2959.6 3181.6 3191.4 3292.8 3357.2 27866.7 28455.6 28669.7 29219.6 29820.6 3214.1 3226.8 3260.1 3297.8 3353.6 238058.0 238821.0 239083.0 239326.0 239600.0 31392.0 32236.5 52719.5 52964.5 53139.5 31122.8 31336.2 31385.7 31406.7 31436.8 13391.5 13533.6 13542.1 13545.8 13548.8 9761.0 10131.4 10149.3 10163.0 10243.4 7247.1 7293.9 7296.1 7498.8 7711.7 3002.8 3022.0 3026.6 3046.6 3051.6 820.6 876.3 901.5 938.9 967.7 26397.5 27888.0 27935.9 28042.6 28434.9 936.8 958.2 962.5 970.3 979.7 13980.8 14744.0 14989.3 15202.8 15278.5 395165.0 401095.0 401325.0 401405.0 622559.0 42470.6 54583.7 56319.0 56598.4 56615.7 1170.4 1189.4 1195.2 1223.1 1226.8 27540.2 28368.7 28876.3 29236.0 29490.9 42372.2 43438.0 43455.3 43458.6 43480.3 331782.0 331897.8 332107.0 332908.0 333389.0 24513.0 24633.4 24997.5 25037.4 25105.5 40540.0 40808.8 41100.8 41262.2 41511.0 34511.5 35049.3 35186.5 35271.3 35477.0 34492.8 34661.7 34857.8 35234.8 35337.1 34439.7 34522.8 34649.5 35016.8 35239.1 29322.0 32014.4 32096.7 32253.5 32277.8 24606.8 24733.4 24794.0 25048.2 25076.4 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | [#2] jquery.html Cycles:180 Average:22328.30 Median:48542.75 stddev:58097.32 (119.7%) stddev-sans-first:58236.83 20:21:36 INFO - PROCESS | 4404 | Values: 334.1 344.7 352.4 356.8 383.7 12203.8 15729.6 15785.8 16808.1 16932.5 15706.6 16028.8 16029.7 16338.9 16429.8 4963.8 4976.2 5111.2 5170.8 5218.7 5060.9 5116.8 5135.9 5239.6 5571.1 5631.9 5633.0 5637.0 5640.7 5641.6 5391.5 5566.8 5600.6 5623.1 5627.2 5428.5 5434.1 5438.6 5439.2 5439.9 12397.1 18903.0 19636.7 19745.1 20822.3 1710.6 1781.2 1949.3 2076.8 2187.0 8995.5 9102.8 9269.4 9382.6 9765.9 1622.2 1633.8 1639.1 1682.2 1745.2 62319.4 62350.7 68087.0 69022.0 71410.0 9622.4 9659.2 9762.7 9803.8 9983.4 13853.1 13866.9 13869.0 13875.9 13890.7 7125.0 7375.7 7522.8 7573.9 7630.6 6545.6 6715.9 6783.6 7039.2 7048.6 4152.8 4239.3 4303.5 4357.5 4371.8 1757.2 1761.8 1762.2 1810.9 1815.1 793.8 859.1 861.3 897.4 912.6 16155.5 16661.1 16760.7 16773.7 17507.5 808.4 815.2 837.8 855.4 857.2 8885.1 9407.9 9549.8 9628.0 9660.9 345146.0 349649.0 352634.0 354047.0 355976.0 44190.0 51004.7 77684.6 79579.0 85302.6 402.7 422.8 424.5 424.6 426.0 9745.7 9793.3 9860.2 9889.0 10272.9 24951.4 26501.7 30494.8 33795.3 35606.8 46073.0 47510.0 49575.5 49985.0 50468.0 7230.9 7255.7 7519.4 7596.4 7624.3 8158.5 10156.4 11675.6 11716.5 12434.9 10196.5 10204.2 10314.8 10388.2 10457.1 9265.0 9397.1 10048.8 10384.4 10444.9 10007.5 10053.6 10323.4 10364.8 10867.3 7381.3 7429.3 7533.4 7576.4 7585.9 10237.2 10316.4 10352.2 10760.5 10890.1 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | [#3] mootools.html Cycles:180 Average:4639.39 Median:4619.84 stddev:2512.54 (54.4%) stddev-sans-first:2506.36 20:21:36 INFO - PROCESS | 4404 | Values: 1208.4 1318.6 1389.7 1417.2 1676.4 5961.4 6572.3 6678.9 6679.5 6852.2 6742.3 6854.3 6871.9 7011.5 7024.0 2037.9 2098.2 2100.2 2101.0 2101.1 2078.3 2123.8 2131.6 2133.6 2134.4 2064.2 2069.3 2086.4 2088.3 2096.4 2010.8 2023.3 2028.6 2030.6 2031.2 1975.0 1988.8 2011.6 2017.1 2020.5 7096.5 7174.0 7202.7 7215.8 7226.7 4208.5 4326.0 4336.2 4337.0 4337.2 2524.3 2730.5 2777.3 2791.9 2797.8 853.6 865.6 868.9 1673.5 1719.0 9341.6 9496.1 9541.7 9559.2 9581.5 3720.3 3791.3 3815.5 3879.1 3887.7 8189.6 8195.3 8197.0 8197.7 8208.9 4306.5 4306.8 4308.4 4318.6 4325.4 3486.5 3581.7 3585.2 3926.7 4019.3 3053.6 3365.9 3375.9 3385.6 3398.6 1083.2 1130.9 1143.4 1149.1 1151.2 775.8 786.7 793.5 812.1 813.6 4687.7 4729.2 4749.8 4782.2 4904.3 371.5 371.9 388.4 389.2 390.8 3193.3 3249.7 3259.2 3282.8 3355.4 7840.7 7997.8 8103.3 8206.8 8264.7 8128.0 8177.4 8189.4 8199.3 8204.8 6376.0 6392.6 6409.4 6479.3 6479.3 4427.7 4480.9 4538.1 4551.9 4698.1 7370.4 7606.0 7734.6 7769.3 7782.9 8135.1 8145.3 8153.6 8179.0 8257.4 6016.8 6155.9 6163.8 6164.9 6167.0 6809.8 6909.1 6960.3 6961.7 6967.3 6188.2 6295.2 6324.1 6332.6 6365.5 6256.1 6325.3 6356.3 6388.6 6410.0 5734.3 5758.7 5778.6 6066.2 6130.1 4025.7 4099.2 4111.2 4131.2 4407.3 4336.3 4354.7 4401.5 4472.7 4489.1 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | [#4] prototype.html Cycles:180 Average:4103.88 Median:4741.68 stddev:1213.97 (25.6%) stddev-sans-first:1183.11 20:21:36 INFO - PROCESS | 4404 | Values: 288.1 291.7 291.7 295.2 300.4 4669.3 4783.7 4815.4 4835.4 4848.8 4730.8 4759.0 4761.0 4762.9 4764.7 3540.9 3543.0 3622.5 3679.9 3685.4 3646.8 3649.0 3659.7 3665.6 3668.3 3619.5 3626.9 3628.5 3631.3 3647.4 3484.6 3555.4 3585.7 3621.3 3631.9 3222.6 3225.4 3227.4 3234.3 3240.2 4597.9 4598.8 4606.3 4608.3 4616.2 4174.5 4177.1 4180.6 4186.7 4221.8 4656.3 4884.5 4916.0 4918.6 4922.6 3497.2 3504.1 3506.4 3506.5 3529.6 5189.2 5190.3 5214.1 5218.7 5227.5 3502.3 3549.6 3564.3 3584.8 3598.7 3609.8 3618.6 3618.9 3628.4 3639.2 4154.9 4170.5 4194.5 4198.5 4221.0 4757.6 4954.3 4983.0 4998.1 5044.9 1197.7 1219.6 1220.3 1224.0 1226.8 778.1 778.8 800.5 805.0 807.7 3948.7 3952.8 4174.8 4251.7 4319.7 5100.3 5110.5 5115.4 5125.3 5133.7 4392.9 4396.2 4402.3 4408.4 4411.4 2581.2 2676.9 2684.1 2700.5 2707.5 4777.7 4793.7 4802.4 4816.2 4821.4 5191.9 5194.3 5195.4 5198.4 5215.4 4581.1 4800.7 4827.8 4838.8 4859.6 5145.5 5147.1 5151.7 5155.7 5163.7 5051.5 5080.8 5088.8 5089.2 5090.9 4667.1 4830.7 4840.6 4845.1 4881.7 3569.4 3578.1 3583.5 3588.1 3589.4 5126.6 5133.0 5146.0 5160.9 5168.4 4786.2 4931.2 4947.7 4975.9 5002.2 4972.3 4976.3 4980.9 4993.7 4996.4 4921.1 4921.9 4933.9 4949.6 4949.9 4742.9 4793.6 4978.3 5034.9 5047.3 4740.5 4776.9 4898.6 4909.1 4912.7 20:21:36 INFO - PROCESS | 4404 | 20:21:36 INFO - PROCESS | 4404 | [#5] yui.html Cycles:180 Average:13642.48 Median:24100.92 stddev:16865.83 (70.0%) stddev-sans-first:16884.83 20:21:36 INFO - PROCESS | 4404 | Values: 628.4 645.2 673.8 683.7 715.1 12092.6 12729.0 12771.1 12832.0 12839.7 11893.5 11998.0 12017.6 12026.5 12033.5 619.0 638.9 644.3 774.9 797.6 629.7 630.1 769.4 791.7 804.8 806.2 808.5 808.6 808.7 811.2 640.4 804.3 805.0 805.3 809.7 485.8 582.2 599.2 599.6 604.4 12840.8 12849.1 12864.2 12877.7 12882.0 10091.7 10196.4 10271.6 10440.3 10592.6 10337.4 10535.8 10615.1 10672.0 10673.7 3625.1 3641.3 3646.1 3659.2 3719.0 47716.0 49381.5 49881.8 50032.5 50392.2 8482.2 8898.1 8904.4 8979.7 8985.5 15768.0 15780.4 15783.5 15811.0 15959.2 6069.3 6160.0 6164.6 6214.2 6351.9 3368.5 3393.5 3408.0 3470.9 3557.8 2445.8 2544.8 2550.1 2551.6 2564.4 462.8 468.1 468.7 469.4 473.0 505.8 508.6 528.1 547.6 559.9 7140.6 7144.8 7242.7 7256.9 7322.3 494.5 529.9 537.5 565.7 588.2 3630.1 3676.4 3720.3 3760.8 3792.3 56005.0 57260.0 58569.1 59324.0 70718.6 55597.9 56084.7 57109.4 58639.0 59208.7 52020.5 52367.7 52611.2 52617.5 55657.7 8014.9 8394.4 8444.2 8544.3 8695.8 35275.0 35809.6 36279.8 36695.4 36734.4 32356.2 32574.3 33483.0 38752.4 43155.6 8533.2 8688.5 10542.2 10834.0 11016.3 9959.5 10030.2 10514.2 11735.6 12023.2 11085.7 11308.3 11465.4 11711.6 12023.6 11241.3 11494.4 11555.7 12484.4 12487.5 10681.3 10694.0 10931.6 11198.0 11234.2 9107.2 9455.8 9466.1 9687.6 9765.0 9759.1 9988.4 10137.2 10167.3 10180.9 20:21:36 INFO - PROCESS | 4404 | -------- Summary: end -------- 20:21:36 INFO - PROCESS | 4404 | 20:21:37 INFO - TEST-INFO | 4404: exit 0 20:21:37 INFO - TEST-OK | dromaeo_css | took 1122000ms 20:21:37 INFO - TEST-START | kraken 20:21:37 INFO - operating with platform_type : linux_ 20:21:37 INFO - Initialising browser for kraken test... 20:21:37 INFO - TEST-INFO | started process 4711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvo0Wv/profile http://localhost:51588/getInfo.html) 20:21:41 INFO - PROCESS | 4711 | __metrics Screen width/height:1600/1200 20:21:41 INFO - PROCESS | 4711 | colorDepth:24 20:21:41 INFO - PROCESS | 4711 | Browser inner width/height: 1024/697 20:21:41 INFO - PROCESS | 4711 | __metrics 20:21:41 INFO - PROCESS | 4711 | 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" 20:21:41 INFO - PROCESS | 4711 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:21:42 INFO - TEST-INFO | 4711: exit 0 20:21:42 INFO - Browser initialized. 20:21:42 INFO - Running cycle 1/1 for kraken test... 20:21:42 INFO - TEST-INFO | started process 4796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvo0Wv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:55 INFO - PROCESS | 4796 | RSS: Main: 173178880 20:21:55 INFO - PROCESS | 4796 | 20:21:57 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:58 INFO - PROCESS | 4796 | RSS: Main: 229842944 20:21:58 INFO - PROCESS | 4796 | 20:22:01 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-dft) 20:22:02 INFO - PROCESS | 4796 | RSS: Main: 216576000 20:22:02 INFO - PROCESS | 4796 | 20:22:05 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-fft) 20:22:06 INFO - PROCESS | 4796 | RSS: Main: 300072960 20:22:06 INFO - PROCESS | 4796 | 20:22:08 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-oscillator) 20:22:09 INFO - PROCESS | 4796 | RSS: Main: 210550784 20:22:09 INFO - PROCESS | 4796 | 20:22:11 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:22:11 INFO - PROCESS | 4796 | RSS: Main: 212480000 20:22:11 INFO - PROCESS | 4796 | 20:22:15 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-darkroom) 20:22:15 INFO - PROCESS | 4796 | RSS: Main: 248504320 20:22:15 INFO - PROCESS | 4796 | 20:22:19 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:19 INFO - PROCESS | 4796 | RSS: Main: 247992320 20:22:19 INFO - PROCESS | 4796 | 20:22:22 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51588/tests/kraken/driver.html?testName=json-parse-financial) 20:22:23 INFO - PROCESS | 4796 | RSS: Main: 247742464 20:22:23 INFO - PROCESS | 4796 | 20:22:24 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:22:25 INFO - PROCESS | 4796 | RSS: Main: 209993728 20:22:25 INFO - PROCESS | 4796 | 20:22:27 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:22:27 INFO - PROCESS | 4796 | RSS: Main: 217034752 20:22:27 INFO - PROCESS | 4796 | 20:22:30 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:22:30 INFO - PROCESS | 4796 | RSS: Main: 226025472 20:22:30 INFO - PROCESS | 4796 | 20:22:33 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:22:34 INFO - PROCESS | 4796 | RSS: Main: 235401216 20:22:34 INFO - PROCESS | 4796 | 20:22:37 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:22:38 INFO - PROCESS | 4796 | RSS: Main: 232382464 20:22:38 INFO - PROCESS | 4796 | 20:22:39 INFO - PROCESS | 4796 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51588/tests/kraken/driver.html?testName=ai-astar) 20:22:40 INFO - PROCESS | 4796 | RSS: Main: 283729920 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | __start_tp_report 20:22:40 INFO - PROCESS | 4796 | _x_x_mozilla_page_load 20:22:40 INFO - PROCESS | 4796 | _x_x_mozilla_page_load_details 20:22:40 INFO - PROCESS | 4796 | |i|pagename|runs| 20:22:40 INFO - PROCESS | 4796 | |0;ai-astar;108;116;114;116;114;115;115;114;115;114 20:22:40 INFO - PROCESS | 4796 | |1;audio-beat-detection;161;129;134;174;133;127;134;128;167;128 20:22:40 INFO - PROCESS | 4796 | |2;audio-dft;163;161;164;164;162;163;163;162;163;160 20:22:40 INFO - PROCESS | 4796 | |3;audio-fft;75;76;76;120;77;79;76;78;101;76 20:22:40 INFO - PROCESS | 4796 | |4;audio-oscillator;86;84;120;85;83;83;109;85;84;126 20:22:40 INFO - PROCESS | 4796 | |5;imaging-gaussian-blur;117;118;117;118;118;119;118;117;116;117 20:22:40 INFO - PROCESS | 4796 | |6;imaging-darkroom;147;146;148;147;146;146;146;146;146;146 20:22:40 INFO - PROCESS | 4796 | |7;imaging-desaturate;85;85;85;85;84;84;85;84;85;85 20:22:40 INFO - PROCESS | 4796 | |8;json-parse-financial;64;62;63;63;62;64;66;63;63;64 20:22:40 INFO - PROCESS | 4796 | |9;json-stringify-tinderbox;65;67;66;66;65;66;66;66;73;67 20:22:40 INFO - PROCESS | 4796 | |10;stanford-crypto-aes;84;84;85;84;84;84;84;84;84;85 20:22:40 INFO - PROCESS | 4796 | |11;stanford-crypto-ccm;153;141;142;152;141;153;155;147;188;146 20:22:40 INFO - PROCESS | 4796 | |12;stanford-crypto-pbkdf2;182;176;179;182;180;177;182;179;182;178 20:22:40 INFO - PROCESS | 4796 | |13;stanford-crypto-sha256-iterative;71;70;72;71;70;70;73;74;71;70 20:22:40 INFO - PROCESS | 4796 | __end_tp_report 20:22:40 INFO - PROCESS | 4796 | __start_cc_report 20:22:40 INFO - PROCESS | 4796 | _x_x_mozilla_cycle_collect,1984 20:22:40 INFO - PROCESS | 4796 | __end_cc_report 20:22:40 INFO - PROCESS | 4796 | __startTimestamp1477538560044__endTimestamp 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | ------- Summary: start ------- 20:22:40 INFO - PROCESS | 4796 | Number of tests: 14 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.28 (2.0%) stddev-sans-first:0.83 20:22:40 INFO - PROCESS | 4796 | Values: 108.0 116.0 114.0 116.0 114.0 115.0 115.0 114.0 115.0 114.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:134.00 stddev:18.27 (13.6%) stddev-sans-first:17.96 20:22:40 INFO - PROCESS | 4796 | Values: 161.0 129.0 134.0 174.0 133.0 127.0 134.0 128.0 167.0 128.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 20:22:40 INFO - PROCESS | 4796 | Values: 163.0 161.0 164.0 164.0 162.0 163.0 163.0 162.0 163.0 160.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.01 (19.8%) stddev-sans-first:15.61 20:22:40 INFO - PROCESS | 4796 | Values: 75.0 76.0 76.0 120.0 77.0 79.0 76.0 78.0 101.0 76.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:84.00 stddev:16.97 (20.2%) stddev-sans-first:17.71 20:22:40 INFO - PROCESS | 4796 | Values: 86.0 84.0 120.0 85.0 83.0 83.0 109.0 85.0 84.0 126.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 20:22:40 INFO - PROCESS | 4796 | Values: 117.0 118.0 117.0 118.0 118.0 119.0 118.0 117.0 116.0 117.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 20:22:40 INFO - PROCESS | 4796 | Values: 147.0 146.0 148.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 20:22:40 INFO - PROCESS | 4796 | Values: 85.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 85.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 20:22:40 INFO - PROCESS | 4796 | Values: 64.0 62.0 63.0 63.0 62.0 64.0 66.0 63.0 63.0 64.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:2.31 (3.5%) stddev-sans-first:2.37 20:22:40 INFO - PROCESS | 4796 | Values: 65.0 67.0 66.0 66.0 65.0 66.0 66.0 66.0 73.0 67.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 20:22:40 INFO - PROCESS | 4796 | Values: 84.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:152.50 stddev:13.78 (9.0%) stddev-sans-first:14.61 20:22:40 INFO - PROCESS | 4796 | Values: 153.0 141.0 142.0 152.0 141.0 153.0 155.0 147.0 188.0 146.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:181.00 stddev:2.26 (1.3%) stddev-sans-first:2.24 20:22:40 INFO - PROCESS | 4796 | Values: 182.0 176.0 179.0 182.0 180.0 177.0 182.0 179.0 182.0 178.0 20:22:40 INFO - PROCESS | 4796 | 20:22:40 INFO - PROCESS | 4796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 20:22:40 INFO - PROCESS | 4796 | Values: 71.0 70.0 72.0 71.0 70.0 70.0 73.0 74.0 71.0 70.0 20:22:40 INFO - PROCESS | 4796 | -------- Summary: end -------- 20:22:40 INFO - PROCESS | 4796 | 20:22:41 INFO - TEST-INFO | 4796: exit 0 20:22:41 INFO - TEST-OK | kraken | took 64306ms 20:22:41 INFO - SUITE-END | took 1186s 20:22:41 INFO - Completed test suite (00:19:46) 20:22:41 INFO - javascript benchmark 20:22:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2500.862452565109, 2517.244826552034, 2545.363659085228, 2553.7956963442925, 2568.242368501292, 4396.340548917664, 4459.375687403766, 4512.5713057259545, 4545.272756358979, 4555.316702494623, 4462.464504259493, 4479.955200447995, 4493.393391892102, 4495.0, 4496.730196188231, 4123.443335149746, 4143.109231515224, 4154.688398370119, 4155.31437312843, 4181.540030596632, 4143.19207754488, 4156.023334516386, 4178.853740119096, 4224.155168966219, 4237.131388065454, 4277.294246449332, 4288.6140247377725, 4289.892752681192, 4299.355096735483, 4306.031142992832, 4284.850030248957, 4289.849855255051, 4292.785360731951, 4308.073764140725, 4328.329108988112, 4063.2482990646827, 4120.114175452262, 4120.278951183531, 4200.1179752252065, 4253.702240843142, 4405.3612226227015, 4573.062522182944, 4573.565511276457, 4604.5165257647795, 4628.0, 4849.369581954358, 4855.344528488679, 4857.708537487762, 4858.441279252896, 4916.311716359713, 4726.456457507396, 4787.234042553209, 4790.305405716186, 4831.371921650163, 4879.463259041502, 4437.400950871655, 4458.7547684877645, 4459.420275364214, 4494.842680506166, 4539.092181563635, 4881.219004959189, 4909.582685471703, 4913.164761990471, 4918.729469879119, 4972.975135124301, 4601.401817763669, 4700.694454860423, 4701.600363969101, 4706.670533062653, 4763.214069678534, 4735.2186889163595, 4786.928196077061, 4788.11419887322, 4828.686135401188, 4849.393825771778, 4810.903781924342, 4820.276958456259, 4826.32431459596, 4867.659263851497, 4876.780544875489, 4798.95201047985, 4808.2787581863, 4810.831620893322, 4815.15734746418, 4872.19608764557, 3766.924661506809, 3774.2828862516585, 3813.275477659236, 3815.4086116651406, 3835.7890316032326, 3364.9327013459592, 3367.562216911786, 3410.6077801053198, 3419.760616756853, 3432.485127230935, 4135.5864413559, 4140.772257525805, 4147.8963025924595, 4150.896227594334, 4196.391523229176, 4662.743549104764, 4719.2921061841, 4804.375431193923, 4804.95195048045, 4851.320815085891, 4081.6938729594804, 4106.384042393605, 4119.0, 4120.237756015147, 4120.855770048034, 4251.532331443539, 4256.616904478612, 4287.699861009762, 4305.268104422255, 4319.33050377192, 4552.271636538138, 4594.724316541018, 4611.861644150681, 4648.86053418398, 4650.883727906829, 4881.487443818348, 4885.047415753894, 4886.340344053508, 4927.433345165208, 4950.777215025405, 4586.0, 4590.540945905383, 4595.885102872455, 4598.0, 4653.650976176733, 4598.333241679871, 4738.099761045391, 4739.952600473951, 4795.832145875017, 4799.688020278811, 4831.855044348676, 4846.854594362175, 4873.098476781806, 4877.219644856806, 4877.341558889504, 4730.952690473051, 4743.881402964954, 4748.169070412733, 4751.548602882721, 4752.168370535073, 4733.7396443194575, 4748.358971538798, 4753.405824271966, 4754.381930349033, 4759.3336932830125, 4656.1851675955895, 4670.509596492319, 4677.391939047902, 4684.7891844867745, 4689.695169813951, 4732.716037037651, 4738.312944622941, 4753.429588449409, 4754.97622511899, 4763.54746299101, 4625.051864367864, 4629.583337499641, 4636.420447444069, 4637.60580350674, 4670.953290467051], "value": 4427.758271467628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2516989479253, 559.6110703061372, 573.4065242474039, 575.0569066730562, 581.5551103405897, 27779.16662500123, 36957.0, 38624.80687596565, 38673.0, 42569.14861702764, 39809.800950995275, 40266.19467610646, 40288.395674064916, 40300.798496007556, 40334.59665403345, 7703.46075774696, 7834.804129896741, 7835.608219588998, 7842.843143137163, 7845.372370210398, 7406.8888966665545, 7547.132079810837, 9823.165030972375, 10146.695599132001, 10152.796944061114, 10193.082622563968, 10251.436171010591, 10255.897441025607, 10260.127889129433, 10266.0, 9973.052560006823, 10028.498575071217, 10038.247131465096, 10039.698809035704, 10041.949790251001, 9977.002299770038, 10044.748881277954, 10045.69862904114, 10050.145737612313, 10055.446950417723, 37301.0, 37509.62490375089, 37551.624483755084, 37572.24855502902, 37704.24591508154, 2959.5856580078807, 3181.602299712536, 3191.377681352137, 3292.818894960776, 3357.1607098225445, 27866.721332786616, 28455.57316640252, 28669.713302866912, 29219.56170657442, 29820.552691709643, 3214.0839860639608, 3226.790258633181, 3260.0871755908383, 3297.8351082445784, 3353.564036675241, 238057.99999999825, 238821.0, 239083.0, 239326.0, 239600.0, 31392.0, 32236.516452253236, 52719.47280527222, 52964.470355295955, 53139.46860531423, 31122.844385777928, 31336.21659458532, 31385.686143138733, 31406.685933140376, 31436.842815785774, 13391.464341426234, 13533.593992180053, 13542.052056356157, 13545.796813047813, 13548.796768048487, 9760.95119524412, 10131.392116472887, 10149.289549731595, 10163.034511721522, 10243.436610986468, 7247.094113235846, 7293.854122917512, 7296.051513303343, 7498.812529686801, 7711.652975616111, 3002.8048176868433, 3021.969780302169, 3026.576279320897, 3046.558249053875, 3051.5575241589845, 820.6184124382191, 876.2639382918379, 901.535709109809, 938.9154976052188, 967.6613185385058, 26397.472050559267, 27888.0, 27935.89858940925, 28042.579361309596, 28434.85782571074, 936.784539555906, 958.2142643032786, 962.4802606592361, 970.3256236915277, 979.6913972098766, 13980.790288145687, 14744.0, 14989.250537473301, 15202.771958420633, 15278.541643750705, 395165.0, 401095.0, 401325.0, 401405.0, 622559.0, 42470.575294246664, 54583.72708136434, 56319.0, 56598.43401565932, 56615.71692141595, 1170.3913964738288, 1189.4052973513071, 1195.2410219510673, 1223.0949097667483, 1226.7975783995719, 27540.173794786187, 28368.71631283661, 28876.27809304784, 29236.0, 29490.852545737132, 42372.15255694807, 43437.96397666442, 43455.34816977811, 43458.56541434545, 43480.34779478374, 331782.0, 331897.83174934227, 332107.0, 332908.0, 333389.0, 24513.0, 24633.38416539529, 24997.500049998533, 25037.374065648506, 25105.49789004173, 40540.0, 40808.79595602003, 41100.79449602733, 41262.1747565053, 41511.0, 34511.4823277656, 35049.299014020085, 35186.47220291646, 35271.294574108884, 35477.0, 34492.82753586216, 34661.65338346685, 34857.825710871286, 35234.8238258807, 35337.116572085906, 34439.65560344364, 34522.82738586291, 34649.48025779565, 35016.82491587526, 35239.11902202466, 29322.0, 32014.35971280608, 32096.679033210305, 32253.51619725659, 32277.838610806797, 24606.753932460448, 24733.381665458506, 24794.0, 25048.248552543453, 25076.373090672878], "value": 16687.169990574268, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.0812764896535, 344.6897791987213, 352.3815703440462, 356.76988342519076, 383.72755343705967, 12203.755924881498, 15729.606759830996, 15785.763213551792, 16808.075555844425, 16932.492025239233, 15706.607334816636, 16028.75956860648, 16029.679406411893, 16338.937969032004, 16429.83570164298, 4963.751812409383, 4976.178930476467, 5111.207762796754, 5170.819021334254, 5218.686878787266, 5060.873478163038, 5116.820911268106, 5135.948640513584, 5239.554637855767, 5571.0807716726695, 5631.859203519924, 5632.986062508747, 5637.0, 5640.746166422521, 5641.633293835908, 5391.541718953894, 5566.777328906839, 5600.635958662674, 5623.0721930881355, 5627.184058311563, 5428.538574221196, 5434.130539113723, 5438.564914806806, 5439.156930675752, 5439.891202175974, 12397.132200745951, 18902.975523916106, 19636.70544941827, 19745.111469983884, 20822.271220507362, 1710.6407654392592, 1781.2251670523235, 1949.2982526290525, 2076.844236682255, 2186.9830528804023, 8995.460272383678, 9102.77243068922, 9269.39748916325, 9382.620012865184, 9765.90234097657, 1622.2375483522726, 1633.7794397756388, 1639.1066868556666, 1682.1757338903972, 1745.1884873533868, 62319.37680623226, 62350.68824655938, 68087.0, 69022.0, 71410.0, 9622.422654640744, 9659.164758695826, 9762.682037924931, 9803.803923921625, 9983.356075032561, 13853.099548529313, 13866.930665346608, 13869.0, 13875.930620346833, 13890.652733681738, 7124.964375178091, 7375.741849035366, 7522.774316770506, 7573.863920411983, 7630.618469076635, 6545.607263564201, 6715.899261511081, 6783.55906866062, 7039.190493093258, 7048.612326321999, 4152.750834949913, 4239.321708526621, 4303.462067241595, 4357.455318085239, 4371.78141092944, 1757.244384914499, 1761.7621621081246, 1762.1805860274778, 1810.9456716298532, 1815.137809540484, 793.8452001859697, 859.0764927702744, 861.2507118806678, 897.3852910756153, 912.5802131019806, 16155.515334539983, 16661.083640399895, 16760.664786704197, 16773.7483937741, 17507.47477575675, 808.3654331349979, 815.2133191470259, 837.7612380471659, 855.3798496090285, 857.1942374168262, 8885.133455937199, 9407.905920940702, 9549.761255968657, 9628.0, 9660.855087173699, 345146.0, 349649.0, 352634.0, 354047.0, 355976.0, 44190.0, 51004.74497627488, 77684.61157694175, 79579.0, 85302.57348713341, 402.66981075517793, 422.78437996621943, 424.4778921926048, 424.5966331984627, 425.97870106494554, 9745.707628771148, 9793.265505087289, 9860.16188623975, 9888.950555247178, 10272.948635256776, 24951.376215594755, 26501.734982650698, 30494.84752576223, 33795.32409351848, 35606.82196589104, 46073.0, 47510.0, 49575.50424495709, 49985.0, 50468.0, 7230.89153662706, 7255.709771609288, 7519.398448124028, 7596.392288616787, 7624.313811756747, 8158.510489370657, 10156.39061656303, 11675.649730508097, 11716.472758726048, 12434.937825310815, 10196.490175491344, 10204.2346823987, 10314.793704125725, 10388.220883433622, 10457.11114555241, 9264.980852106128, 9397.060293970822, 10048.84926726085, 10384.42885641297, 10444.947775261075, 10007.549660265451, 10053.597856085968, 10323.432211228455, 10364.844527332247, 10867.347959122479, 7381.335679788845, 7429.257074292527, 7533.434992375484, 7576.356009739234, 7585.9379686842785, 10237.181025517792, 10316.43259620728, 10352.223583231138, 10760.515776789907, 10890.128789696964], "value": 7712.199115182881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.3595694282023, 1318.61760089574, 1389.6873203529206, 1417.1922004457456, 1676.3732099405636, 5961.403859614036, 6572.342765723425, 6678.866422671544, 6679.532432729705, 6852.246252912176, 6742.325767423267, 6854.348836860503, 6871.931280687191, 7011.544249623784, 7024.0166376707175, 2037.898105094743, 2098.244631932503, 2100.170432679091, 2101.023024293703, 2101.138533201388, 2078.347585376564, 2123.8088572028514, 2131.6269652810697, 2133.5946170227685, 2134.3703607435764, 2064.1846470644164, 2069.306782227948, 2086.383053133818, 2088.3212955789354, 2096.360610013945, 2010.7687615924137, 2023.261509549004, 2028.5537181819975, 2030.5634288627941, 2031.238285642884, 1975.0, 1988.8309493693052, 2011.5574573593785, 2017.0923084611984, 2020.5049762808205, 7096.467764917652, 7174.0315057467615, 7202.747903823393, 7215.819604509877, 7226.674799634029, 4208.516020657633, 4325.978370108161, 4336.197803406349, 4336.956630433687, 4337.154254920292, 2524.2679622909336, 2730.5221586222333, 2777.264025033368, 2791.8553393108728, 2797.804153709221, 853.5732133933034, 865.5931712095305, 868.913108689126, 1673.548142001665, 1719.0, 9341.579628916646, 9496.097870702271, 9541.666041688577, 9559.235261179088, 9581.520923953844, 3720.330340538675, 3791.33651610967, 3815.465834783133, 3879.1465877506903, 3887.747296425723, 8189.590520473953, 8195.303399211014, 8197.0, 8197.71308004229, 8208.876866847002, 4306.4832220133785, 4306.784660766949, 4308.418363520885, 4318.5681431856565, 4325.43769309994, 3486.4944583035317, 3581.71346292296, 3585.1754096557415, 3926.6662333701956, 4019.2966230909474, 3053.587765651653, 3365.865365385406, 3375.8818441354433, 3385.5768028996376, 3398.575178102737, 1083.1767856429171, 1130.8812574679541, 1143.3997151495532, 1149.0864762513822, 1151.2459339132881, 775.83707421441, 786.6813940354166, 793.4644115222202, 812.0864027968536, 813.6297984417076, 4687.742174180453, 4729.219678752967, 4749.810007599657, 4782.163121453801, 4904.2643603459765, 371.48178291283506, 371.88471573812205, 388.37277796358677, 389.24098008882794, 390.8280356643068, 3193.297474555594, 3249.675032496779, 3259.152620318687, 3282.7537934654997, 3355.3624811286268, 7840.725574604861, 7997.8400431992195, 8103.270705636521, 8206.794830129294, 8264.710735124241, 8127.959360203161, 8177.386695997824, 8189.426740128253, 8199.262066413932, 8204.794880128045, 6376.0, 6392.648404337806, 6409.359064093554, 6479.254885688112, 6479.319671434526, 4427.693830320128, 4480.924578101298, 4538.1377538267625, 4551.931721024253, 4698.130845793539, 7370.44721645868, 7605.961970190114, 7734.6132693366235, 7769.300762931363, 7782.883256751266, 8135.145809689898, 8145.348372130334, 8153.6330865112395, 8179.0, 8257.42198046131, 6016.759329626941, 6155.907661384993, 6163.7842675506145, 6164.876702466016, 6167.0, 6809.829754256183, 6909.067275917687, 6960.338767817049, 6961.6519174042105, 6967.2684368142645, 6188.164597779242, 6295.18162638854, 6324.051392291193, 6332.588381755171, 6365.490760739037, 6256.124142620128, 6325.335839736761, 6356.3325850785, 6388.648624325707, 6410.0, 5734.254546908875, 5758.683272419889, 5778.624389414675, 6066.15073889647, 6130.141780150871, 4025.6779457642733, 4099.159672267118, 4111.239420707178, 4131.235721391552, 4407.316865885793, 4336.262835317941, 4354.673399494987, 4401.471823381215, 4472.731636101845, 4489.0572979674635], "value": 3747.3772708552456, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.1298478594644, 291.66604238147323, 291.74472336705384, 295.1646839444373, 300.3947046700898, 4669.34629151919, 4783.689060211088, 4815.351556643849, 4835.395575553056, 4848.806047758086, 4730.763461826903, 4758.952410475894, 4761.000759362135, 4762.9285560716535, 4764.666473346859, 3540.8583656653705, 3543.0256679413237, 3622.492851000849, 3679.871204507843, 3685.4287585424167, 3646.781193128421, 3648.963510364902, 3659.6706296433317, 3665.6437118266144, 3668.266346730651, 3619.511365965587, 3626.9455958160647, 3628.5282913221245, 3631.2737452509473, 3647.379945409287, 3484.6409900138965, 3555.3600351936643, 3585.713142948558, 3621.257642183346, 3631.854725810951, 3222.6455089940087, 3225.4194245035883, 3227.3706627207703, 3234.2884565395575, 3240.2061494933655, 4597.850537365659, 4598.816047358102, 4606.309053641947, 4608.33179189019, 4616.215243408628, 4174.499060112776, 4177.143685544456, 4180.561041090703, 4186.748795072305, 4221.767802770846, 4656.32483289921, 4884.462709101996, 4915.975420122876, 4918.557329840296, 4922.606191504707, 3497.2480916603054, 3504.088936876405, 3506.386382383073, 3506.4915587239707, 3529.5588051493564, 5189.221616757479, 5190.273361729361, 5214.113600687854, 5218.66078704883, 5227.503387178212, 3502.2820321833965, 3549.6095429502734, 3564.3049605326714, 3584.7669901456843, 3598.676119149289, 3609.787289312514, 3618.620044895301, 3618.873339433107, 3628.4375921732176, 3639.1993761372455, 4154.875353739392, 4170.4995400552125, 4194.496660400771, 4198.538160802309, 4220.978895105566, 4757.643176761757, 4954.256861470808, 4982.975085124624, 4998.100341938413, 5044.9495505045215, 1197.6766273106211, 1219.6280134559045, 1220.261741646309, 1223.9938800305943, 1226.8037114061708, 778.0585491555281, 778.8208711996273, 800.519688187083, 805.0379796143552, 807.6648191000669, 3948.6505529210076, 3952.8023598819946, 4174.83300667976, 4251.681978586648, 4319.719218250866, 5100.285959965608, 5110.540051395392, 5115.444765887747, 5125.2568377585785, 5133.666311689728, 4392.879815646989, 4396.1867054595, 4402.273624851928, 4408.448943882015, 4411.382406463098, 2581.1802679111183, 2676.8661566921965, 2684.1276585109918, 2700.51390749663, 2707.4991126641635, 4777.713337199779, 4793.712377257376, 4802.375691160127, 4816.229403295456, 4821.397325334333, 5191.896162076738, 5194.27280180775, 5195.428502864682, 5198.428172900978, 5215.374155101412, 4581.106684196549, 4800.66395352329, 4827.782749776268, 4838.846628340876, 4859.586935110555, 5145.459726728789, 5147.124988751996, 5151.6908985461, 5155.664881782672, 5163.690178589297, 5051.494850514919, 5080.771365288497, 5088.753255452438, 5089.185730283137, 5090.949090509195, 4667.113248482778, 4830.734309613005, 4840.564349208447, 4845.127876982177, 4881.658283920092, 3569.411047177187, 3578.0697018774786, 3583.51622530955, 3588.1209103769743, 3589.443636236283, 5126.590187698413, 5133.0, 5145.974270128625, 5160.896782064263, 5168.405633352213, 4786.234202527578, 4931.161702510653, 4947.6536642434685, 4975.850724478271, 5002.199648056294, 4972.3038774572315, 4976.32819569368, 4980.900381992412, 4993.726599717049, 4996.425411077773, 4921.114199444134, 4921.926171107508, 4933.851984440473, 4949.57928576075, 4949.851504454872, 4742.857714268577, 4793.640476964172, 4978.30303757467, 5034.917492739079, 5047.318611987334, 4740.502247263988, 4776.8566942991765, 4898.583620392306, 4909.140900342354, 4912.729799860899], "value": 3714.2787819917894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.4281304013349, 645.245063275967, 673.8012286375518, 683.6718375179913, 715.0668377767014, 12092.637220883376, 12729.0, 12771.106022578424, 12832.0, 12839.743205135892, 11893.52425902963, 11998.040156787436, 12017.639470815868, 12026.458809353579, 12033.518659253641, 618.9783357582486, 638.8977763557832, 644.3105876711896, 774.9418793590476, 797.5972134072285, 629.735511085343, 630.0675000998525, 769.3537428560008, 791.7387262203488, 804.7625950344662, 806.238104990781, 808.4744915804715, 808.5835794565803, 808.7169490678274, 811.168552233959, 640.4300172846171, 804.3123129724119, 804.9879251811227, 805.3275514945028, 809.6963638635511, 485.83967290793953, 582.2401765695765, 599.241958921964, 599.5922772514688, 604.4348534120611, 12840.807387889188, 12849.100562960597, 12864.163829351062, 12877.67805804853, 12882.0, 10091.747706307327, 10196.439195844225, 10271.6404925828, 10440.269181157322, 10592.62925797601, 10337.379757214516, 10535.789284214272, 10615.097716694014, 10672.03951644348, 10673.668402182113, 3625.093726568358, 3641.308151451216, 3646.1431563582537, 3659.1949771050326, 3718.9814050929845, 47716.0, 49381.50618493841, 49881.750591247175, 50032.49967500315, 50392.24411633828, 8482.194191551793, 8898.11018898105, 8904.421212621159, 8979.685711000215, 8985.502924761302, 15768.0, 15780.368785248691, 15783.526494205193, 15811.0, 15959.202039897958, 6069.302030266487, 6159.969200153971, 6164.599301045418, 6214.1921550198185, 6351.936480635227, 3368.545246391755, 3393.4570468724887, 3407.9659203408146, 3470.913227169341, 3557.768745031565, 2445.792107670868, 2544.75824796644, 2550.09471637566, 2551.553478141318, 2564.423004823937, 462.7686156921539, 468.06153661908337, 468.6859803931374, 469.3546373736113, 473.02556733129865, 505.76734702036737, 508.6236185222908, 528.0785030122461, 547.5920439272767, 559.8600349912522, 7140.642967851691, 7144.821379465555, 7242.674079666428, 7256.8911466328045, 7322.340989310987, 494.4659767451144, 529.9046171689056, 537.5081800152894, 565.6945249565189, 588.2411688921244, 3630.110622897407, 3676.3750162472443, 3720.330340538729, 3760.8495660173835, 3792.27946690128, 56005.0, 57260.0, 58569.12146317809, 59324.0, 70718.64640676764, 55597.888042239734, 56084.71957640268, 57109.42890571124, 58639.0, 59208.7039564808, 52020.479795201565, 52367.73816130971, 52611.210831837554, 52617.47382526202, 55657.72171139118, 8014.919850801417, 8394.37042221848, 8444.215712237137, 8544.273736732448, 8695.826083478421, 35275.0, 35809.64190358167, 36279.83703666654, 36695.449568257034, 36734.44898326474, 32356.191095222806, 32574.348513029134, 33483.0, 38752.418713718755, 43155.568444315155, 8533.189347012023, 8688.52213128284, 10542.15662746963, 10834.0, 11016.283941543774, 9959.502024898871, 10030.247731420319, 10514.158867290751, 11735.589254376056, 12023.158378913393, 11085.667429977113, 11308.264962777394, 11465.426728663366, 11711.648650540497, 12023.63929082129, 11241.325520468798, 11494.367809770543, 11555.711107222387, 12484.375781211085, 12487.500499980262, 10681.252312338062, 10694.0, 10931.617393391192, 11198.04816590599, 11234.213605047895, 9107.22588579978, 9455.810106526005, 9466.05339466048, 9687.612495500101, 9765.0, 9759.12167904892, 9988.400695957975, 10137.239707021856, 10167.288289819937, 10180.898191018292], "value": 5843.70229755502, "unit": "score"}], "name": "dromaeo_css", "value": 5993.510456002058, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 114.0, 116.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 129.0, 134.0, 174.0, 133.0, 127.0, 134.0, 128.0, 167.0, 128.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 164.0, 162.0, 163.0, 163.0, 162.0, 163.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 120.0, 77.0, 79.0, 76.0, 78.0, 101.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 120.0, 85.0, 83.0, 83.0, 109.0, 85.0, 84.0, 126.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 117.0, 116.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 62.0, 64.0, 66.0, 63.0, 63.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 73.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 141.0, 142.0, 152.0, 141.0, 153.0, 155.0, 147.0, 188.0, 146.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 176.0, 179.0, 182.0, 180.0, 177.0, 182.0, 179.0, 182.0, 178.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 71.0, 70.0, 70.0, 73.0, 74.0, 71.0, 70.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1561.6000000000001, "alertThreshold": 2.0}]} 20:22:41 INFO - Return code: 0 20:22:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:22:41 INFO - # TBPL SUCCESS # 20:22:41 INFO - Running post-action listener: _resource_record_post_action 20:22:41 INFO - [mozharness: 2016-10-27 03:22:41.866148Z] Finished run-tests step (success) 20:22:41 INFO - Running post-run listener: _resource_record_post_run 20:22:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 407236608; Read time: 244; Write time: 214564 20:22:41 INFO - TinderboxPrint: CPU usage
13.0% 20:22:41 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 244 20:22:41 INFO - TinderboxPrint: I/O write bytes / time
407,236,608 / 214,564 20:22:41 INFO - TinderboxPrint: CPU idle
8,347.4 (87.0%) 20:22:41 INFO - TinderboxPrint: CPU user
1,203.2 (12.5%) 20:22:41 INFO - TinderboxPrint: Swap in / out
0 / 0 20:22:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115728384; Read time: 160; Write time: 66340 20:22:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290598912; Read time: 68; Write time: 148196 20:22:42 INFO - Running post-run listener: _upload_blobber_files 20:22:42 INFO - Blob upload gear active. 20:22:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:22:42 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 20:22:42 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:22:42 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:22:42 INFO - (blobuploader) - INFO - Open directory for files ... 20:22:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:22:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:22:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:43 INFO - (blobuploader) - INFO - Done attempting. 20:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:22:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:44 INFO - (blobuploader) - INFO - Done attempting. 20:22:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:22:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:47 INFO - (blobuploader) - INFO - Done attempting. 20:22:47 INFO - (blobuploader) - INFO - Iteration through files over. 20:22:47 INFO - Return code: 0 20:22:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:22:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:22:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b324cd1cf71c38867ae19223afc1e586f5b885ed1430d467ac2cb8896ae7a70c54ed68ac7849fc78f40d9e5f3ee356d61c87316ed75d2023f4ec21acf85e0dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c115a7a5513dde43630242b8a906726c1fe3d827a54c770f63c006282a21d4485827a775890cc032d407c01688f164f9d7eec28c515b0aa1746cace91496992a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cac1b8caad51a201794f007df3f460c1d8d0d2b796b514210e5f79757510b5b4b22b2dea57ef292e5f3b81922f860fcd824d2d27279e146da3cd336b8e967eb5"} 20:22:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:22:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:22:47 INFO - Contents: 20:22:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b324cd1cf71c38867ae19223afc1e586f5b885ed1430d467ac2cb8896ae7a70c54ed68ac7849fc78f40d9e5f3ee356d61c87316ed75d2023f4ec21acf85e0dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c115a7a5513dde43630242b8a906726c1fe3d827a54c770f63c006282a21d4485827a775890cc032d407c01688f164f9d7eec28c515b0aa1746cace91496992a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cac1b8caad51a201794f007df3f460c1d8d0d2b796b514210e5f79757510b5b4b22b2dea57ef292e5f3b81922f860fcd824d2d27279e146da3cd336b8e967eb5"} 20:22:47 INFO - Running post-run listener: copy_logs_to_upload_dir 20:22:47 INFO - Copying logs to upload dir... 20:22:47 INFO - mkdir: /builds/slave/test/build/upload/logs 20:22:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.784210 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-26 20:22:47.181024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 20:22:47.184647) ========= 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=337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b324cd1cf71c38867ae19223afc1e586f5b885ed1430d467ac2cb8896ae7a70c54ed68ac7849fc78f40d9e5f3ee356d61c87316ed75d2023f4ec21acf85e0dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c115a7a5513dde43630242b8a906726c1fe3d827a54c770f63c006282a21d4485827a775890cc032d407c01688f164f9d7eec28c515b0aa1746cace91496992a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cac1b8caad51a201794f007df3f460c1d8d0d2b796b514210e5f79757510b5b4b22b2dea57ef292e5f3b81922f860fcd824d2d27279e146da3cd336b8e967eb5"} build_url:https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://queue.taskcluster.net/v1/task/NdSmcY1QQe-VQ1SUKaB3tw/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/Firefox-Non-PGO/sha512/2b324cd1cf71c38867ae19223afc1e586f5b885ed1430d467ac2cb8896ae7a70c54ed68ac7849fc78f40d9e5f3ee356d61c87316ed75d2023f4ec21acf85e0dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c115a7a5513dde43630242b8a906726c1fe3d827a54c770f63c006282a21d4485827a775890cc032d407c01688f164f9d7eec28c515b0aa1746cace91496992a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cac1b8caad51a201794f007df3f460c1d8d0d2b796b514210e5f79757510b5b4b22b2dea57ef292e5f3b81922f860fcd824d2d27279e146da3cd336b8e967eb5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 20:22:47.214110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:22:47.214813) ========= 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=337fe3f4b1febe37b85fccc40000019e-1477535476.193976-1177460354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:22:47.300683) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 20:22:47.301325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 20:22:47.301970) ========= ========= Total master_lag: 0.17 =========