builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1475828741.01 results: success (0) buildid: 20161006223005 builduid: d9a9850b6d184328be6c35b3a803829f revision: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.007137) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.007696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.007981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.064850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.065258) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 01:25:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-07 01:25:41 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.177758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.178051) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020303 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.240184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.240542) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 --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 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 --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=82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 01:25:41,381 truncating revision to first 12 chars 2016-10-07 01:25:41,381 Setting DEBUG logging. 2016-10-07 01:25:41,382 attempt 1/10 2016-10-07 01:25:41,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4b9944879c9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 01:25:41,699 unpacking tar archive at: mozilla-central-4b9944879c9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644996 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.904495) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.904801) ========= script_repo_revision: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.905206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.905524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.916313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-07 01:25:41.916793) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:42 INFO - MultiFileLogger online at 20161007 01:25:42 in /builds/slave/test 01:25:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:25:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:42 INFO - {'append_to_log': False, 01:25:42 INFO - 'base_work_dir': '/builds/slave/test', 01:25:42 INFO - 'blob_upload_branch': 'Firefox', 01:25:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:42 INFO - 'branch': 'Firefox', 01:25:42 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:42 INFO - 'config_files': ('talos/linux_config.py',), 01:25:42 INFO - 'default_actions': ('clobber', 01:25:42 INFO - 'read-buildbot-config', 01:25:42 INFO - 'download-and-extract', 01:25:42 INFO - 'populate-webroot', 01:25:42 INFO - 'create-virtualenv', 01:25:42 INFO - 'install', 01:25:42 INFO - 'run-tests'), 01:25:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:42 INFO - 'download_minidump_stackwalk': True, 01:25:42 INFO - 'download_symbols': 'ondemand', 01:25:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:42 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:42 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:42 INFO - 'installer_path': 'installer.exe', 01:25:42 INFO - 'log_level': 'info', 01:25:42 INFO - 'log_name': 'talos', 01:25:42 INFO - 'log_to_console': True, 01:25:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:42 INFO - 'opt_config_files': (), 01:25:42 INFO - 'pip_index': False, 01:25:42 INFO - 'sps_profile': False, 01:25:42 INFO - 'sps_profile_interval': 0, 01:25:42 INFO - 'suite': 'dromaeojs', 01:25:42 INFO - 'system_bits': '32', 01:25:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:42 INFO - 'title': 'talos-linux64-ix-066', 01:25:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:42 INFO - 'use_talos_json': True, 01:25:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:42 INFO - 'work_dir': 'build'} 01:25:42 INFO - [mozharness: 2016-10-07 08:25:42.152969Z] Running clobber step. 01:25:42 INFO - Running pre-action listener: _resource_record_pre_action 01:25:42 INFO - Running main action method: clobber 01:25:42 INFO - rmtree: /builds/slave/test/build 01:25:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:42 INFO - Running post-action listener: _resource_record_post_action 01:25:42 INFO - [mozharness: 2016-10-07 08:25:42.606476Z] Finished clobber step (success) 01:25:42 INFO - [mozharness: 2016-10-07 08:25:42.606578Z] Running read-buildbot-config step. 01:25:42 INFO - Running pre-action listener: _resource_record_pre_action 01:25:42 INFO - Running main action method: read_buildbot_config 01:25:42 INFO - Using buildbot properties: 01:25:42 INFO - { 01:25:42 INFO - "project": "", 01:25:42 INFO - "product": "firefox", 01:25:42 INFO - "script_repo_revision": "production", 01:25:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:25:42 INFO - "repository": "", 01:25:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:25:42 INFO - "buildid": "20161006223005", 01:25:42 INFO - "pgo_build": "True", 01:25:42 INFO - "basedir": "/builds/slave/test", 01:25:42 INFO - "buildnumber": 23, 01:25:42 INFO - "slavename": "talos-linux64-ix-066", 01:25:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:25:42 INFO - "platform": "ubuntu64_hw", 01:25:42 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:25:42 INFO - "branch": "mozilla-central", 01:25:42 INFO - "repo_path": "mozilla-central", 01:25:42 INFO - "revision": "4b9944879c9a60a9aba4a744a7401bc38e0f39c4", 01:25:42 INFO - "stage_platform": "linux64-pgo", 01:25:42 INFO - "builduid": "d9a9850b6d184328be6c35b3a803829f", 01:25:42 INFO - "slavebuilddir": "test" 01:25:42 INFO - } 01:25:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:25:42 INFO - Running post-action listener: _resource_record_post_action 01:25:42 INFO - [mozharness: 2016-10-07 08:25:42.609343Z] Finished read-buildbot-config step (success) 01:25:42 INFO - [mozharness: 2016-10-07 08:25:42.609434Z] Running download-and-extract step. 01:25:42 INFO - Running pre-action listener: _resource_record_pre_action 01:25:42 INFO - Running main action method: download_and_extract 01:25:42 INFO - mkdir: /builds/slave/test/build/tests 01:25:42 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')]} 01:25:42 INFO - trying https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:43 INFO - Downloaded 1361 bytes. 01:25:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:25:43 INFO - Using the following test package requirements: 01:25:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:25:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:25:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'jsshell-linux-x86_64.zip'], 01:25:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:25:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:25:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:25:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:25:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:25:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:25:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:25:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:25:43 INFO - Http code: 200 01:25:43 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 01:25:43 INFO - x-amz-cf-id: KLl7Ge5TK1v7ZsrPtjqwrb9eyDL81aJ_yRx9WCvcg17LkekT77dArw== 01:25:43 INFO - x-amz-version-id: ENqAKZdcwkNp_PoIQSnv3.fyMJqaW9Lf 01:25:44 INFO - Expected file size: 22021944 01:25:44 INFO - Obtained file size: 22021944 01:25:48 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 01:25:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:25:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:25:48 INFO - Http code: 200 01:25:48 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 01:25:48 INFO - x-amz-cf-id: l3lgT5_Kh6qXTsybjalfrj8bgs8l8J4shIVQuD96OC2bmncGuPqzvg== 01:25:48 INFO - x-amz-version-id: ENqAKZdcwkNp_PoIQSnv3.fyMJqaW9Lf 01:25:48 INFO - Expected file size: 22021944 01:25:48 INFO - Obtained file size: 22021944 01:25:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:25:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:25:53 INFO - Http code: 200 01:25:53 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 01:25:53 INFO - x-amz-cf-id: vbQtqW665Tt9A_f9UrlqsELWKeAkRviCo2l4IMmLRYjgIAQ0wIJ6ZA== 01:25:53 INFO - x-amz-version-id: tlldmenZnEXbICnb7_0_lM4bqSRxjXf. 01:25:54 INFO - Expected file size: 14409006 01:25:54 INFO - Obtained file size: 14409006 01:25: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')]} 01:25:54 INFO - trying https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:57 INFO - Downloaded 59711881 bytes. 01:25:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:57 INFO - mkdir: /builds/slave/test/properties 01:25:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:57 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:57 INFO - Contents: 01:25:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:57 INFO - Running post-action listener: _resource_record_post_action 01:25:57 INFO - Running post-action listener: set_extra_try_arguments 01:25:57 INFO - [mozharness: 2016-10-07 08:25:57.893928Z] Finished download-and-extract step (success) 01:25:57 INFO - [mozharness: 2016-10-07 08:25:57.894156Z] Running populate-webroot step. 01:25:57 INFO - Running pre-action listener: _resource_record_pre_action 01:25:57 INFO - Running main action method: populate_webroot 01:25:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:57 INFO - '--tppagecycles', 01:25:57 INFO - '7'], 01:25:57 INFO - 'tests': ['tsvgm']}}, 01:25:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['damp', 'tps']}, 01:25:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'tests': ['damp', 'tps']}, 01:25:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['dromaeo_dom']}, 01:25:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['basic_compositor_video']}, 01:25:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:25:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['a11yr', 01:25:57 INFO - 'ts_paint', 01:25:57 INFO - 'tpaint', 01:25:57 INFO - 'sessionrestore', 01:25:57 INFO - 'sessionrestore_no_auto_restore', 01:25:57 INFO - 'tabpaint']}, 01:25:57 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:57 INFO - 'ts_paint', 01:25:57 INFO - 'tpaint', 01:25:57 INFO - 'sessionrestore', 01:25:57 INFO - 'sessionrestore_no_auto_restore', 01:25:57 INFO - 'tabpaint']}, 01:25:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:57 INFO - 'ts_paint', 01:25:57 INFO - 'tpaint', 01:25:57 INFO - 'sessionrestore', 01:25:57 INFO - 'sessionrestore_no_auto_restore', 01:25:57 INFO - 'tabpaint']}, 01:25:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:57 INFO - 'ts_paint', 01:25:57 INFO - 'tpaint', 01:25:57 INFO - 'sessionrestore', 01:25:57 INFO - 'sessionrestore_no_auto_restore', 01:25:57 INFO - 'tabpaint']}, 01:25:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['a11yr', 01:25:57 INFO - 'ts_paint', 01:25:57 INFO - 'tpaint', 01:25:57 INFO - 'sessionrestore', 01:25:57 INFO - 'sessionrestore_no_auto_restore', 01:25:57 INFO - 'tabpaint']}, 01:25:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['a11yr', 01:25:57 INFO - 'ts_paint', 01:25:57 INFO - 'tpaint', 01:25:57 INFO - 'sessionrestore', 01:25:57 INFO - 'sessionrestore_no_auto_restore', 01:25:57 INFO - 'tabpaint']}, 01:25:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['tsvgx', 01:25:57 INFO - 'tsvgr_opacity', 01:25:57 INFO - 'tart', 01:25:57 INFO - 'tscrollx', 01:25:57 INFO - 'cart']}, 01:25:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:57 INFO - 'tsvgr_opacity', 01:25:57 INFO - 'tart', 01:25:57 INFO - 'tscrollx', 01:25:57 INFO - 'cart']}, 01:25:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'talos_options': ['--disable-e10s'], 01:25:57 INFO - 'tests': ['tp5o']}, 01:25:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'tests': ['tp5o']}, 01:25:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'talos_options': ['--disable-e10s', 01:25:57 INFO - '--xperf_path', 01:25:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:57 INFO - 'tests': ['tp5n']}, 01:25:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:57 INFO - 'talos_options': ['--xperf_path', 01:25:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:57 INFO - 'tests': ['tp5n']}}, 01:25:57 INFO - 'talos.zip': {'path': '', 01:25:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:57 INFO - Running post-action listener: _resource_record_post_action 01:25:57 INFO - [mozharness: 2016-10-07 08:25:57.914445Z] Finished populate-webroot step (success) 01:25:57 INFO - [mozharness: 2016-10-07 08:25:57.914534Z] Running create-virtualenv step. 01:25:57 INFO - Running pre-action listener: _resource_record_pre_action 01:25:57 INFO - Running main action method: create_virtualenv 01:25:57 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:57 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 01:25:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:58 INFO - Using real prefix '/usr' 01:25:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:58 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:00 INFO - Installing pip.................done. 01:26:00 INFO - Return code: 0 01:26:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:26:00 INFO - Reading from file tmpfile_stdout 01:26:00 INFO - Output received: 01:26:00 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) 01:26:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:26:00 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')]} 01:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:00 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')]} 01:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:00 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:00 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 01:26:00 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 01:26:00 INFO - Using env: {'DISPLAY': ':0', 01:26:00 INFO - 'HOME': '/home/cltbld', 01:26:00 INFO - 'LANG': 'en_US.UTF-8', 01:26:00 INFO - 'LANGUAGE': 'en_US:en', 01:26:00 INFO - 'LOGNAME': 'cltbld', 01:26:00 INFO - 'MAIL': '/var/mail/cltbld', 01:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:00 INFO - 'MOZ_NO_REMOTE': '1', 01:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:00 INFO - 'NO_EM_RESTART': '1', 01:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:00 INFO - 'PWD': '/builds/slave/test', 01:26:00 INFO - 'SHELL': '/bin/bash', 01:26:00 INFO - 'SHLVL': '1', 01:26:00 INFO - 'TERM': 'linux', 01:26:00 INFO - 'TMOUT': '86400', 01:26:00 INFO - 'USER': 'cltbld', 01:26:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:00 INFO - '_': '/tools/buildbot/bin/python'} 01:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:00 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 01:26:00 INFO - Cleaning up... 01:26:00 INFO - Return code: 0 01:26:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:26:00 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')]} 01:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:00 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')]} 01:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:00 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:00 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 01:26:00 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 01:26:00 INFO - Using env: {'DISPLAY': ':0', 01:26:00 INFO - 'HOME': '/home/cltbld', 01:26:00 INFO - 'LANG': 'en_US.UTF-8', 01:26:00 INFO - 'LANGUAGE': 'en_US:en', 01:26:00 INFO - 'LOGNAME': 'cltbld', 01:26:00 INFO - 'MAIL': '/var/mail/cltbld', 01:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:00 INFO - 'MOZ_NO_REMOTE': '1', 01:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:00 INFO - 'NO_EM_RESTART': '1', 01:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:00 INFO - 'PWD': '/builds/slave/test', 01:26:00 INFO - 'SHELL': '/bin/bash', 01:26:00 INFO - 'SHLVL': '1', 01:26:00 INFO - 'TERM': 'linux', 01:26:00 INFO - 'TMOUT': '86400', 01:26:00 INFO - 'USER': 'cltbld', 01:26:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:00 INFO - '_': '/tools/buildbot/bin/python'} 01:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:01 INFO - Downloading/unpacking psutil>=3.1.1 01:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:03 INFO - Installing collected packages: psutil 01:26:03 INFO - Running setup.py install for psutil 01:26:03 INFO - building 'psutil._psutil_linux' extension 01:26:03 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 01:26:03 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 01:26:03 INFO - building 'psutil._psutil_posix' extension 01:26:03 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 01:26:03 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 01:26:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:03 INFO - Successfully installed psutil 01:26:03 INFO - Cleaning up... 01:26:03 INFO - Return code: 0 01:26:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:26:03 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')]} 01:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:03 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')]} 01:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:03 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:03 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 01:26:03 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 01:26:03 INFO - Using env: {'DISPLAY': ':0', 01:26:03 INFO - 'HOME': '/home/cltbld', 01:26:03 INFO - 'LANG': 'en_US.UTF-8', 01:26:03 INFO - 'LANGUAGE': 'en_US:en', 01:26:03 INFO - 'LOGNAME': 'cltbld', 01:26:03 INFO - 'MAIL': '/var/mail/cltbld', 01:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:03 INFO - 'MOZ_NO_REMOTE': '1', 01:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:03 INFO - 'NO_EM_RESTART': '1', 01:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:03 INFO - 'PWD': '/builds/slave/test', 01:26:03 INFO - 'SHELL': '/bin/bash', 01:26:03 INFO - 'SHLVL': '1', 01:26:03 INFO - 'TERM': 'linux', 01:26:03 INFO - 'TMOUT': '86400', 01:26:03 INFO - 'USER': 'cltbld', 01:26:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:03 INFO - '_': '/tools/buildbot/bin/python'} 01:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:26:03 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 01:26:03 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 01:26:03 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 01:26:03 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 01:26:03 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 01:26:03 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 01:26:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:26:05 INFO - Installing collected packages: mozsystemmonitor 01:26:05 INFO - Running setup.py install for mozsystemmonitor 01:26:05 INFO - Successfully installed mozsystemmonitor 01:26:05 INFO - Cleaning up... 01:26:05 INFO - Return code: 0 01:26:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:06 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:06 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 01:26:06 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 01:26:06 INFO - Using env: {'DISPLAY': ':0', 01:26:06 INFO - 'HOME': '/home/cltbld', 01:26:06 INFO - 'LANG': 'en_US.UTF-8', 01:26:06 INFO - 'LANGUAGE': 'en_US:en', 01:26:06 INFO - 'LOGNAME': 'cltbld', 01:26:06 INFO - 'MAIL': '/var/mail/cltbld', 01:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:06 INFO - 'MOZ_NO_REMOTE': '1', 01:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:06 INFO - 'NO_EM_RESTART': '1', 01:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:06 INFO - 'PWD': '/builds/slave/test', 01:26:06 INFO - 'SHELL': '/bin/bash', 01:26:06 INFO - 'SHLVL': '1', 01:26:06 INFO - 'TERM': 'linux', 01:26:06 INFO - 'TMOUT': '86400', 01:26:06 INFO - 'USER': 'cltbld', 01:26:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:06 INFO - '_': '/tools/buildbot/bin/python'} 01:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:06 INFO - Downloading/unpacking jsonschema==2.5.1 01:26:06 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 01:26:06 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 01:26:06 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 01:26:06 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 01:26:06 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 01:26:06 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 01:26:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:08 INFO - warning: no files found matching '*.txt' 01:26:08 INFO - no previously-included directories found matching 'build' 01:26:08 INFO - no previously-included directories found matching 'dist' 01:26:08 INFO - no previously-included directories found matching '.git*' 01:26:08 INFO - Installing collected packages: jsonschema, functools32 01:26:08 INFO - Running setup.py install for functools32 01:26:08 INFO - warning: no files found matching '*.txt' 01:26:08 INFO - no previously-included directories found matching 'build' 01:26:08 INFO - no previously-included directories found matching 'dist' 01:26:08 INFO - no previously-included directories found matching '.git*' 01:26:08 INFO - Successfully installed jsonschema functools32 01:26:08 INFO - Cleaning up... 01:26:08 INFO - Return code: 0 01:26:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:26:08 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')]} 01:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:08 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')]} 01:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:08 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:08 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 01:26:08 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 01:26:08 INFO - Using env: {'DISPLAY': ':0', 01:26:08 INFO - 'HOME': '/home/cltbld', 01:26:08 INFO - 'LANG': 'en_US.UTF-8', 01:26:08 INFO - 'LANGUAGE': 'en_US:en', 01:26:08 INFO - 'LOGNAME': 'cltbld', 01:26:08 INFO - 'MAIL': '/var/mail/cltbld', 01:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:08 INFO - 'MOZ_NO_REMOTE': '1', 01:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:08 INFO - 'NO_EM_RESTART': '1', 01:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:08 INFO - 'PWD': '/builds/slave/test', 01:26:08 INFO - 'SHELL': '/bin/bash', 01:26:08 INFO - 'SHLVL': '1', 01:26:08 INFO - 'TERM': 'linux', 01:26:08 INFO - 'TMOUT': '86400', 01:26:08 INFO - 'USER': 'cltbld', 01:26:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:08 INFO - '_': '/tools/buildbot/bin/python'} 01:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:26:08 INFO - Cleaning up... 01:26:08 INFO - Return code: 0 01:26:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:26:08 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')]} 01:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:08 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')]} 01:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:08 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:08 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 01:26:08 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 01:26:08 INFO - Using env: {'DISPLAY': ':0', 01:26:08 INFO - 'HOME': '/home/cltbld', 01:26:08 INFO - 'LANG': 'en_US.UTF-8', 01:26:08 INFO - 'LANGUAGE': 'en_US:en', 01:26:08 INFO - 'LOGNAME': 'cltbld', 01:26:08 INFO - 'MAIL': '/var/mail/cltbld', 01:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:08 INFO - 'MOZ_NO_REMOTE': '1', 01:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:08 INFO - 'NO_EM_RESTART': '1', 01:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:08 INFO - 'PWD': '/builds/slave/test', 01:26:08 INFO - 'SHELL': '/bin/bash', 01:26:08 INFO - 'SHLVL': '1', 01:26:08 INFO - 'TERM': 'linux', 01:26:08 INFO - 'TMOUT': '86400', 01:26:08 INFO - 'USER': 'cltbld', 01:26:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:08 INFO - '_': '/tools/buildbot/bin/python'} 01:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:08 INFO - Downloading/unpacking blobuploader==1.2.4 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:10 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:26:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26:11 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 01:26:11 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 01:26:11 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 01:26:11 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 01:26:11 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 01:26:11 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 01:26:11 INFO - Downloading docopt-0.6.1.tar.gz 01:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:11 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:11 INFO - Running setup.py install for blobuploader 01:26:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:26:11 INFO - Running setup.py install for requests 01:26:12 INFO - Running setup.py install for docopt 01:26:12 INFO - Successfully installed blobuploader requests docopt 01:26:12 INFO - Cleaning up... 01:26:12 INFO - Return code: 0 01:26:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:12 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:12 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 01:26:12 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 01:26:12 INFO - Using env: {'DISPLAY': ':0', 01:26:12 INFO - 'HOME': '/home/cltbld', 01:26:12 INFO - 'LANG': 'en_US.UTF-8', 01:26:12 INFO - 'LANGUAGE': 'en_US:en', 01:26:12 INFO - 'LOGNAME': 'cltbld', 01:26:12 INFO - 'MAIL': '/var/mail/cltbld', 01:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:12 INFO - 'MOZ_NO_REMOTE': '1', 01:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:12 INFO - 'NO_EM_RESTART': '1', 01:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:12 INFO - 'PWD': '/builds/slave/test', 01:26:12 INFO - 'SHELL': '/bin/bash', 01:26:12 INFO - 'SHLVL': '1', 01:26:12 INFO - 'TERM': 'linux', 01:26:12 INFO - 'TMOUT': '86400', 01:26:12 INFO - 'USER': 'cltbld', 01:26:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:12 INFO - '_': '/tools/buildbot/bin/python'} 01:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:12 INFO - Running setup.py (path:/tmp/pip-2Lll0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:12 INFO - Running setup.py (path:/tmp/pip-3OiQgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:12 INFO - Running setup.py (path:/tmp/pip-aD5v6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:12 INFO - Running setup.py (path:/tmp/pip-mbOaVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:12 INFO - Running setup.py (path:/tmp/pip-LSQ7a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:12 INFO - Running setup.py (path:/tmp/pip-ebAb2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:12 INFO - Running setup.py (path:/tmp/pip-Byx69P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:12 INFO - Running setup.py (path:/tmp/pip-uSio3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:13 INFO - Running setup.py (path:/tmp/pip-5PT4gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:13 INFO - Running setup.py (path:/tmp/pip-S_myxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:13 INFO - Running setup.py (path:/tmp/pip-ZPKIyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:13 INFO - Running setup.py (path:/tmp/pip-pyvw20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:13 INFO - Running setup.py (path:/tmp/pip-YDAL_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:13 INFO - Running setup.py (path:/tmp/pip-DjdGBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:13 INFO - Running setup.py (path:/tmp/pip-QqmPTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:13 INFO - Running setup.py (path:/tmp/pip-oAEyGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:13 INFO - Running setup.py (path:/tmp/pip-p_ApKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:13 INFO - Running setup.py install for manifestparser 01:26:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:26:13 INFO - Running setup.py install for mozcrash 01:26:13 INFO - Running setup.py install for mozdebug 01:26:13 INFO - Running setup.py install for mozdevice 01:26:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozfile 01:26:14 INFO - Running setup.py install for mozhttpd 01:26:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozinfo 01:26:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozInstall 01:26:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozleak 01:26:14 INFO - Running setup.py install for mozlog 01:26:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for moznetwork 01:26:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozprocess 01:26:14 INFO - Running setup.py install for mozprofile 01:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozrunner 01:26:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozscreenshot 01:26:15 INFO - Running setup.py install for moztest 01:26:15 INFO - Running setup.py install for mozversion 01:26:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:15 INFO - Cleaning up... 01:26:15 INFO - Return code: 0 01:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:15 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')]} 01:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:15 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')]} 01:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:15 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:15 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 01:26:15 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 01:26:15 INFO - Using env: {'DISPLAY': ':0', 01:26:15 INFO - 'HOME': '/home/cltbld', 01:26:15 INFO - 'LANG': 'en_US.UTF-8', 01:26:15 INFO - 'LANGUAGE': 'en_US:en', 01:26:15 INFO - 'LOGNAME': 'cltbld', 01:26:15 INFO - 'MAIL': '/var/mail/cltbld', 01:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:15 INFO - 'MOZ_NO_REMOTE': '1', 01:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:15 INFO - 'NO_EM_RESTART': '1', 01:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:15 INFO - 'PWD': '/builds/slave/test', 01:26:15 INFO - 'SHELL': '/bin/bash', 01:26:15 INFO - 'SHLVL': '1', 01:26:15 INFO - 'TERM': 'linux', 01:26:15 INFO - 'TMOUT': '86400', 01:26:15 INFO - 'USER': 'cltbld', 01:26:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:15 INFO - '_': '/tools/buildbot/bin/python'} 01:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:15 INFO - Running setup.py (path:/tmp/pip-XXdv8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:15 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)) 01:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:15 INFO - Running setup.py (path:/tmp/pip-vZE36Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:15 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)) 01:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:15 INFO - Running setup.py (path:/tmp/pip-J_k2EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:15 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)) 01:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:15 INFO - Running setup.py (path:/tmp/pip-uhzxma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:16 INFO - Running setup.py (path:/tmp/pip-5ZnpHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 INFO - Running setup.py (path:/tmp/pip-jEun5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:16 INFO - Running setup.py (path:/tmp/pip-vcnk9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:16 INFO - Running setup.py (path:/tmp/pip-sixH4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:16 INFO - Running setup.py (path:/tmp/pip-TP0lTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:16 INFO - Running setup.py (path:/tmp/pip-YMceTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:16 INFO - Running setup.py (path:/tmp/pip-YCkvZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:16 INFO - Running setup.py (path:/tmp/pip-RmudBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:16 INFO - Running setup.py (path:/tmp/pip-kKjtb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:16 INFO - Running setup.py (path:/tmp/pip-0JxVaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:16 INFO - Running setup.py (path:/tmp/pip-fNNzfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:16 INFO - Running setup.py (path:/tmp/pip-COcTbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:16 INFO - Running setup.py (path:/tmp/pip-trhjFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:16 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)) 01:26:16 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)) 01:26:16 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)) 01:26:16 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)) 01:26:16 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)) 01:26:16 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)) 01:26:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:16 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 01:26:16 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 01:26:16 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 01:26:16 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 01:26:16 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 01:26:16 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 01:26:18 INFO - Downloading blessings-1.6.tar.gz 01:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:19 INFO - Installing collected packages: blessings 01:26:19 INFO - Running setup.py install for blessings 01:26:19 INFO - Successfully installed blessings 01:26:19 INFO - Cleaning up... 01:26:19 INFO - Return code: 0 01:26:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:19 INFO - Reading from file tmpfile_stdout 01:26:19 INFO - Current package versions: 01:26:19 INFO - argparse == 1.2.1 01:26:19 INFO - blessings == 1.6 01:26:19 INFO - blobuploader == 1.2.4 01:26:19 INFO - docopt == 0.6.1 01:26:19 INFO - functools32 == 3.2.3-2 01:26:19 INFO - jsonschema == 2.5.1 01:26:19 INFO - manifestparser == 1.1 01:26:19 INFO - mozInstall == 1.12 01:26:19 INFO - mozcrash == 0.17 01:26:19 INFO - mozdebug == 0.1 01:26:19 INFO - mozdevice == 0.48 01:26:19 INFO - mozfile == 1.2 01:26:19 INFO - mozhttpd == 0.7 01:26:19 INFO - mozinfo == 0.9 01:26:19 INFO - mozleak == 0.1 01:26:19 INFO - mozlog == 3.4 01:26:19 INFO - moznetwork == 0.27 01:26:19 INFO - mozprocess == 0.23 01:26:19 INFO - mozprofile == 0.28 01:26:19 INFO - mozrunner == 6.12 01:26:19 INFO - mozscreenshot == 0.1 01:26:19 INFO - mozsystemmonitor == 0.3 01:26:19 INFO - moztest == 0.7 01:26:19 INFO - mozversion == 1.4 01:26:19 INFO - psutil == 3.1.1 01:26:19 INFO - requests == 1.2.3 01:26:19 INFO - wsgiref == 0.1.2 01:26:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:19 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 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26:19 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 01:26:19 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 01:26:19 INFO - Using env: {'DISPLAY': ':0', 01:26:19 INFO - 'HOME': '/home/cltbld', 01:26:19 INFO - 'LANG': 'en_US.UTF-8', 01:26:19 INFO - 'LANGUAGE': 'en_US:en', 01:26:19 INFO - 'LOGNAME': 'cltbld', 01:26:19 INFO - 'MAIL': '/var/mail/cltbld', 01:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:19 INFO - 'MOZ_NO_REMOTE': '1', 01:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:19 INFO - 'NO_EM_RESTART': '1', 01:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:19 INFO - 'PWD': '/builds/slave/test', 01:26:19 INFO - 'SHELL': '/bin/bash', 01:26:19 INFO - 'SHLVL': '1', 01:26:19 INFO - 'TERM': 'linux', 01:26:19 INFO - 'TMOUT': '86400', 01:26:19 INFO - 'USER': 'cltbld', 01:26:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:19 INFO - '_': '/tools/buildbot/bin/python'} 01:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 INFO - Cleaning up... 01:26:19 INFO - Return code: 0 01:26:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8454b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', '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 01:26: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', 'jsonschema'] in /builds/slave/test/build 01:26: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 jsonschema 01:26:19 INFO - Using env: {'DISPLAY': ':0', 01:26:19 INFO - 'HOME': '/home/cltbld', 01:26:19 INFO - 'LANG': 'en_US.UTF-8', 01:26:19 INFO - 'LANGUAGE': 'en_US:en', 01:26:19 INFO - 'LOGNAME': 'cltbld', 01:26:19 INFO - 'MAIL': '/var/mail/cltbld', 01:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:19 INFO - 'MOZ_NO_REMOTE': '1', 01:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:19 INFO - 'NO_EM_RESTART': '1', 01:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:19 INFO - 'PWD': '/builds/slave/test', 01:26:19 INFO - 'SHELL': '/bin/bash', 01:26:19 INFO - 'SHLVL': '1', 01:26:19 INFO - 'TERM': 'linux', 01:26:19 INFO - 'TMOUT': '86400', 01:26:19 INFO - 'USER': 'cltbld', 01:26:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:19 INFO - '_': '/tools/buildbot/bin/python'} 01:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:26:19 INFO - Cleaning up... 01:26:19 INFO - Return code: 0 01:26:19 INFO - Running post-action listener: _resource_record_post_action 01:26:19 INFO - Running post-action listener: _start_resource_monitoring 01:26:19 INFO - Starting resource monitoring. 01:26:19 INFO - [mozharness: 2016-10-07 08:26:19.906088Z] Finished create-virtualenv step (success) 01:26:19 INFO - [mozharness: 2016-10-07 08:26:19.906546Z] Running install step. 01:26:19 INFO - Running pre-action listener: _resource_record_pre_action 01:26:19 INFO - Running main action method: install 01:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:20 INFO - Reading from file tmpfile_stdout 01:26:20 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:20 INFO - Reading from file tmpfile_stdout 01:26:20 INFO - Output received: 01:26:20 INFO - Usage: mozinstall [options] installer 01:26:20 INFO - Options: 01:26:20 INFO - -h, --help show this help message and exit 01:26:20 INFO - -d DEST, --destination=DEST 01:26:20 INFO - Directory to install application into. [default: 01:26:20 INFO - "/builds/slave/test"] 01:26:20 INFO - --app=APP Application being installed. [default: firefox] 01:26:20 INFO - mkdir: /builds/slave/test/build/application 01:26:20 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'] 01:26:20 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 01:26:37 INFO - Reading from file tmpfile_stdout 01:26:37 INFO - Output received: 01:26:37 INFO - /builds/slave/test/build/application/firefox/firefox 01:26:37 INFO - Running post-action listener: _resource_record_post_action 01:26:37 INFO - [mozharness: 2016-10-07 08:26:37.208128Z] Finished install step (success) 01:26:37 INFO - [mozharness: 2016-10-07 08:26:37.208374Z] Running run-tests step. 01:26:37 INFO - Running pre-action listener: _resource_record_pre_action 01:26:37 INFO - Running main action method: run_tests 01:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:26:37 INFO - Python 2.7.3 01:26:37 INFO - Return code: 0 01:26:37 INFO - grabbing minidump binary from tooltool 01:26: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')]} 01:26:37 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 0x246a930>, '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 0x246b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:26:37 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 01:26:37 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 01:26:37 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 01:26:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:26:37 INFO - Return code: 0 01:26:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:26:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:26:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:26:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:26:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 01:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 01:26:37 INFO - Using env: {'DISPLAY': ':0', 01:26:37 INFO - 'HOME': '/home/cltbld', 01:26:37 INFO - 'LANG': 'en_US.UTF-8', 01:26:37 INFO - 'LANGUAGE': 'en_US:en', 01:26:37 INFO - 'LOGNAME': 'cltbld', 01:26:37 INFO - 'MAIL': '/var/mail/cltbld', 01:26:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:37 INFO - 'MOZ_NO_REMOTE': '1', 01:26:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:37 INFO - 'NO_EM_RESTART': '1', 01:26:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:37 INFO - 'PWD': '/builds/slave/test', 01:26:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:37 INFO - 'SHELL': '/bin/bash', 01:26:37 INFO - 'SHLVL': '1', 01:26:37 INFO - 'TERM': 'linux', 01:26:37 INFO - 'TMOUT': '86400', 01:26:37 INFO - 'USER': 'cltbld', 01:26:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320', 01:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:37 INFO - '_': '/tools/buildbot/bin/python'} 01:26:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 01:26:37 INFO - mozversion application_buildid: 20161006223005 01:26:37 INFO - mozversion application_changeset: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 01:26:37 INFO - mozversion application_display_name: Nightly 01:26:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:26:37 INFO - mozversion application_name: Firefox 01:26:37 INFO - mozversion application_remotingname: firefox 01:26:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:26:37 INFO - mozversion application_vendor: Mozilla 01:26:37 INFO - mozversion application_version: 52.0a1 01:26:37 INFO - mozversion platform_buildid: 20161006223005 01:26:37 INFO - mozversion platform_changeset: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 01:26:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:26:37 INFO - mozversion platform_version: 52.0a1 01:26:37 INFO - using testdate: 1475828797 01:26:37 INFO - actual date: 1475828797 01:26:37 INFO - starting webserver on 'localhost:41641' 01:26:37 INFO - SUITE-START | Running 2 tests 01:26:37 INFO - TEST-START | dromaeo_css 01:26:37 INFO - operating with platform_type : linux_ 01:26:37 INFO - Initialising browser for dromaeo_css test... 01:26:37 INFO - TEST-INFO | started process 7194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmplRCj/profile http://localhost:41641/getInfo.html) 01:26:42 INFO - PROCESS | 7194 | __metrics Screen width/height:1600/1200 01:26:42 INFO - PROCESS | 7194 | colorDepth:24 01:26:42 INFO - PROCESS | 7194 | Browser inner width/height: 1024/697 01:26:42 INFO - PROCESS | 7194 | __metrics 01:26:43 INFO - PROCESS | 7194 | 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" 01:26:43 INFO - PROCESS | 7194 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:44 INFO - PROCESS | 7194 | console.error: PushService: 01:26:44 INFO - PROCESS | 7194 | stateChangeProcessEnqueue: Error transitioning state 01:26:44 INFO - PROCESS | 7194 | UnknownError 01:26:44 INFO - TEST-INFO | 7194: exit 0 01:26:44 INFO - Browser initialized. 01:26:44 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:44 INFO - TEST-INFO | started process 7274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmplRCj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:56 INFO - PROCESS | 7274 | RSS: Main: 173961216 01:26:56 INFO - PROCESS | 7274 | 01:27:48 INFO - PROCESS | 7274 | 1475828868514 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] 01:29:58 INFO - PROCESS | 7274 | Cycle 1(1): loaded http://localhost:41641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41641/tests/dromaeo/cssquery-ext.html) 01:30:00 INFO - PROCESS | 7274 | RSS: Main: 416210944 01:30:00 INFO - PROCESS | 7274 | 01:33:03 INFO - PROCESS | 7274 | Cycle 1(1): loaded http://localhost:41641/tests/dromaeo/cssquery-ext.html (next: http://localhost:41641/tests/dromaeo/cssquery-jquery.html) 01:33:04 INFO - PROCESS | 7274 | RSS: Main: 288903168 01:33:04 INFO - PROCESS | 7274 | 01:36:06 INFO - PROCESS | 7274 | Cycle 1(1): loaded http://localhost:41641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41641/tests/dromaeo/cssquery-mootools.html) 01:36:06 INFO - PROCESS | 7274 | RSS: Main: 222724096 01:36:06 INFO - PROCESS | 7274 | 01:39:08 INFO - PROCESS | 7274 | Cycle 1(1): loaded http://localhost:41641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41641/tests/dromaeo/cssquery-prototype.html) 01:39:09 INFO - PROCESS | 7274 | RSS: Main: 246562816 01:39:09 INFO - PROCESS | 7274 | 01:42:12 INFO - PROCESS | 7274 | Cycle 1(1): loaded http://localhost:41641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41641/tests/dromaeo/cssquery-yui.html) 01:42:12 INFO - PROCESS | 7274 | RSS: Main: 222224384 01:42:12 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | Cycle 1(1): loaded http://localhost:41641/tests/dromaeo/cssquery-yui.html (next: http://localhost:41641/tests/dromaeo/cssquery-dojo.html) 01:45:15 INFO - PROCESS | 7274 | RSS: Main: 294555648 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | __start_tp_report 01:45:15 INFO - PROCESS | 7274 | _x_x_mozilla_page_load 01:45:15 INFO - PROCESS | 7274 | _x_x_mozilla_page_load_details 01:45:15 INFO - PROCESS | 7274 | |i|pagename|runs| 01:45:15 INFO - PROCESS | 7274 | |0;dojo.html;2985.9999999999995;3015.170828022294;3016.7737419693512;3037.863296151673;3059.311654877653;5045.646804723661;5126.487351264872;5137.409197942237;5219.5041471060285;5219.739013049351;5081.491850814917;5110.361204849394;5123.385193776743;5125.538701516863;5154.278401023859;4745.406824146981;4762.97618511907;4764.309175169598;4788.018456216485;4788.90422191556;4727.479977202505;4738.597219236369;4784.186688263004;4793.233082706767;4805.303231031498;4783.067301876135;4795.280707893827;4808.3508726322025;4817.445993710733;4863;4652.55800698933;4683.344331793552;4779.737114458703;4790.329353890458;4813.302071199674;4631.490536041033;4663.580277774982;4666.673332866701;4721.622270218374;4735.57379835813;5020.59835213182;5022.497750224985;5073.822416215452;5109.821156259513;5125.4618265082;5472.26124473195;5476.644018138848;5477;5482.23248745176;5546.77812887484;5396.406395296514;5450.482204190595;5507.862303442446;5508.228847961289;5527.005139074965;5127.359080115023;5147.1507201312115;5168.7415629218385;5172.560332371715;5193;5621.606487545832;5627.184058311604;5632.070708333161;5633.746481408347;5696.971515142398;5305.495977882095;5326.334208223972;5404.675719456845;5408.675479471166;5456.563474921997;5538.75075621598;5550.250716153349;5552.750126244328;5605.271314729059;5620.297462817148;5518.944810551923;5521.585881058937;5527.585431092684;5532.557395408438;5590.524805391506;5353.946460535422;5355.946440535623;5408.378036525771;5525.309336332958;5530;4187.706860519735;4233.5131459881895;4278.529361770203;4281.678874084456;4283.057727299989;3770.1894092770185;3833.252515759456;3840.615938406193;3845.750026248285;3869.4195870619633;5100.158473851847;5119.667221630582;5126.1798112302595;5126.53861152498;5178.663386879841;5398.62209645321;5398.757055932492;5400.270963419966;5414.35027796667;5450.4549545045975;5159.871003224949;5209.426963034063;5218.295530103387;5223.4515375884985;5271.156614941591;4745.1695953208055;4751.429828420612;4753.524647535219;4764.166270902579;4785.59322457595;5440.102383106743;5548.722563871709;5575.330960284792;5587.189857470644;5623.831285061373;5321;5358.839234822962;5375.81184658535;5378.973105134606;5383.515483606494;5412.512873841373;5448.4006759257245;5450.182472629137;5450.373207081077;5452.645578037414;5227.451117632746;5261.57907367402;5262.26328314044;5270.7101109439345;5293.232481290114;5354.089804733283;5362.410134885082;5368.624196306221;5369.409364969928;5375.5162035417;5229.686218826882;5234.057869583511;5238.659487133325;5239;5240.082985477602;5225.608079394136;5227.712475813714;5227.869303267449;5230.555402790653;5311.893762124813;5260.526552610283;5350.5184533392185;5353.732313384237;5358.115910874662;5359.249705041219;5415.431379705232;5433.130699088127;5434.918476222781;5495.065838807493;5501.422350653123;5146.279520867157;5184.948150518447;5272.841814745564;5338.225957236256;5348.705821179872 01:45:15 INFO - PROCESS | 7274 | |1;ext.html;595.5920194666653;612.6385432594768;615.1234490850538;619.9225096862892;632.2886752403546;42438;43306.78346608266;43989.34015989755;44332.3350149748;48421.27368089482;44767.55232447683;44847.103057938904;45310;45384.09231815362;45395.04932179406;7692.730754423596;7836.686532538692;8756.91243087569;8948.284137269004;8959.820803583925;10564.788704225912;10817.83773243402;10832.566697332137;11226.887731122706;11238.157138214625;10876;10935.125189984821;10954.507047182857;10956.671299861016;10964.780704385908;10837.891621083807;10887.945560272226;10890.673279801618;10891.945540272327;10898.128149748001;10609.098226650667;10622.628208012682;10698.839517407245;10703.946480267627;10708.089812365959;42072.158556828996;42276.78861605672;42389.36415953733;42556.78721606372;42563.36154957678;3399.0285634332026;3415.9316813663836;3455.9827200863833;3778.7123908120184;3857.691384689218;31693.841530792197;31798.364032719448;31980;31995.680043199503;33388.33223335544;4269.2744016922525;4455.264881294583;4501.212287849613;4564.338170965225;4630.583247507707;349831;350360;350402;352460;354207;59490;59566;59867;59916.70041649764;59953;36303.818480907954;36842.447363289575;36904.26191476209;39054.41418378727;61708.38291617116;16945.49163525096;17092.40176593813;17107.914460427866;17111.486655400357;17122.82877171237;11994.88005119955;12260.877391225973;12797.360131993362;12982.805257921138;13048.934755326352;18990.62018759617;19137.330193443162;19190.61618767617;19229.90385048094;19294.517637058903;7091.219965803757;7134.643267836587;7175.677094530759;7178.2103968563415;7275.89086163708;921.3412410126791;1058.333250052462;1089.1939964426267;1133.82992551118;1142.1388876517426;31422.21444463861;31613;31664.525032124537;31756.841215794237;32237.677623223935;1094.141099237095;1117.580907159815;1117.7429191285887;1131.4286285425808;1138.1805100327751;15966;17130.143492825307;17132.486025419257;17159.828401716073;17227.31090756356;477678;479103;480992;481777;481903;58481;59023.40976590179;59044;59069.704651476466;59084.7045764777;1210.6610149158073;1251.1804767876872;1300.1808860417875;1335.6260247130624;1339.4842985450477;29637.2590685226;32491.67508324981;32762.83618581892;32799.83600081984;33394.49908251427;49961.250581242035;50638.2404263929;50665.74667126641;50678;50686.746566266935;367294;368856;368985;369055;369250;27924;29091.418171636873;29094.27264318409;29108.417831643674;29125;46419.30371044505;47088.52911470841;47351.52648473471;47569.52430475651;47615.523844762494;39492;40057.599424005384;40065.799671001456;41271.1745765077;41600.79199603983;39729;40044.79977600093;40118;41357.93210339411;42151;39516.80241598774;39816.60183398129;40878.1824363517;41262;41413.792931035154;33299.83350083234;36067.0983225411;36159.27681446409;36574.63425365819;36969.15154242223;27282.590761138203;27508.312292192855;27818;27988.58017129704;28109 01:45:15 INFO - PROCESS | 7274 | |2;jquery.html;366.3808164202496;367.62508219259956;379.9639034291743;388.2661769256106;400.8556919508976;14344.856551434483;17734.64530709385;18092;18156.45530634083;18306.450806475812;17083.743743843854;17269.740953885703;17305.13474326285;17453.47639570815;17824.73262901054;4871.366722326093;5093.363329583802;5123.077845987721;5200.6879587224885;5213.86965325868;3846.8845934622004;4034.253663072326;5236.973815130919;5272.841814745564;5481;5745.396733343002;5778.855528611797;5780.9710951445395;5786.768529258825;5794.362620111784;5607.130894711306;5772.365039845614;5820.35976042635;5845.298564172326;5851.180834683148;5690.857728556778;5694.259746233005;5694.6867922264255;5695.77216911323;5699.57253206007;21513.24703635381;22047.33857984263;22175.334739957827;23222.53554928892;23488.412789680224;2223.499712564676;2362.019761798869;2523.3060908250195;2645.761881430661;2847.658281006272;9281.30390220736;9735.756606084833;10051.095401413835;10208.387496750145;10224.335418197794;1785.7767779027622;1857;1877.2866310801808;1938.6510428122933;1979.2379933725476;74274;79440;79861;80003.79984800659;86009.13990860137;10628.946855265674;10788.190885683449;10996.560137594566;11201.039818031812;11335.943320283512;15670.294836732375;15681.764773528406;15694.293756780973;15721;15752.369905203892;8150.3479721622125;8359.916400835913;8384.287335576422;8471;8552.700655477152;7772.222777722182;7935.841283174304;8228.876566851503;8357.498550087013;8412.873806892901;4649.256119021008;4752.643551733634;4785.928211076836;4800.3279540864305;4880;1938.185961896007;1962.9214831406869;1999.4901300168656;2000.2399088346335;2021.4036859126593;914.7987442762582;931.9021502742114;945.9952700236455;946.6308139825474;977.1352353167498;18522.444326670222;19641.901790490956;19761.60476790485;19800.207991680458;19832.60334793325;970.5972021611094;998.1515711645044;999.2305924438142;1015.5531566111035;1028.5268776362957;10266;10887.237893347548;10934.21177599707;10940.835887461695;11005.17461190414;443860;445985;448180;456096;457087;87694.05376758061;91175.54412227897;91732;92131.53934230286;92165.5391723037;1005.4470041477158;1007.1137399088901;1033.7674023344687;1048.0724558765396;1071.1163290285544;16283.185840708155;16821.831781682027;17037.829621703626;17361.218745156246;17683.20425580826;41714.37428438515;42481;42787.57212427836;42924.35613465738;42934.78532607317;59022;59298.40701592929;59593.404065958784;60053.69973150281;60829.69585152046;8302.54336011525;8317.251447369767;8398.202170793766;8490.702825401082;8554.401191916755;12743.745125097632;13129;13245.27151006704;13249.668758281121;13399.866001339862;11572.247803893057;11596.130290228099;11841.82237266459;11865.169438139248;12198.51205951752;11292.887071129184;11426.771464570827;11467.655970320904;11673.824892626788;12051.216670916363;11457;11546.191766576596;11660.591879284184;11718.23831450953;12005.219660722025;8423.831523369376;8515.40392172542;8577.828443430972;8753.387262891536;8796.384253102222;10284.434356110187;11137.665870023913;11207.159463040467;11223.38271395081;11616.767664646492 01:45:15 INFO - PROCESS | 7274 | |3;mootools.html;1225.442423697218;1421.1331088036295;1473.5358362115933;1583.7386831172857;1764.267828851027;7679.846403071935;8701.91298087019;8972.461652300859;9000.45997240166;9231.584578693959;9025.142611451902;9087.681931132413;9098.363114581982;9100.089991000897;9104.135107164826;2311.9422014449606;2342.2387723989686;2345.906163753448;2346.1436575649936;2346.296111166643;2202.3503066595395;2233.5421238646118;2261.332906792492;2263.20787724296;2263.5359751250953;2244.6969659096058;2278.8063014643776;2283.748787633359;2284.4745708487058;2292.151903795598;2224.510607666311;2228.4874478869788;2243.517643706603;2248.415411992877;2249.5838269920037;2189.1243502598927;2190.6823510591034;2192.550527141932;2196.3301193136085;2199.3951663292564;8703.56391195452;8954.37319387643;9039.909600903973;9068.229200517964;9083.22792562633;5163.070647283487;5368.62419630626;5368.892622147574;5369.6509726867625;5378.386484054768;3393.7963722176746;3397.405454045532;3430.6569343065494;3464.3071385722956;3497.3355062538035;1081.3403823667556;1103.4979084516526;1120.5965852293168;1165.0795871261694;1173.049829637996;12582.496700131984;12735.108542402035;12800.231986080866;12823.166494177849;12832.165909215964;4388.539203383662;4414.977925110354;4583.931241031387;4585.564371384713;4620;10033.849492257623;10051.145652619463;10053.79892402148;10063.295569310225;10070.798584028278;5290.470952904679;5291.259223708684;5294.470552944752;5296.099663057213;5301.3373328333955;4364.345348197732;4509.932351014738;4790.137775200497;4901.191303434894;4941.50584941503;3688.354537955847;3722.8696995605565;3839.30892439358;3865.4588357629955;3867.7679339239735;1075.3010543147018;1101.8457415961773;1105.082781291526;1116.5031560955297;1117.173291764105;834.1616675241344;847.4491580472742;847.5042100371229;878.6748902905965;888.8044630181349;5223.347081614798;5279.1817268323475;5358.33020872391;5379.193121031798;5471.06991811393;418.071880425455;420.21839378755493;423.55949812194973;425.58080290913426;431;3507.7544571880235;3537.646235376493;3546.3971124908826;3551.982240088783;3603.7117030637487;11119.777604447865;11481.196316257781;11570.132240082028;11584.304941703525;11587.88412115885;11288.492017859217;11489.080873530098;11507.367094809699;11515.76968460626;11516.481758320895;8340.541270230196;8346.582670866554;8451.788705282417;8454.28138608213;8461.830763384698;5289.894202116013;5342.652727572696;5413.648112872651;5503.917441238465;5621.304724966842;10034;10213.33613315132;10234.795304094025;10235.795284094127;10315;10232.795344092927;10382.48087595602;10566.366018038942;10617.097546708308;10756.838647420138;6329.367063293634;6485.156929599122;6500.967495162494;7431.331180193809;7513.924860751323;8616.827663446822;8969.237614802554;9002.504862232377;9011.2790976723;9022.278217742696;7592.468527203043;7633.5419874807685;7753.1859154787935;7920.643571039433;7922.603869806602;7620.428467865043;7696.807579810549;7738.961305193438;7825.569593672175;7826.491278066907;6848;6938.965305173442;6946.930530694628;6947.930520694728;6959.512834101564;4997.525235102659;5062.392512898476;5065.8733531662;5116.4627714090975;5313.601479889101;4725.10223057618;4737.147313483606;4822.662413631012;5006.424261210008;5070.366204224472 01:45:15 INFO - PROCESS | 7274 | |4;prototype.html;316.5346939998202;325.3931417905606;327.99469625597544;331.4696485623003;333.0607686324566;5047.369078865142;5191.792328306863;5214.270002199691;5260.2898608687865;5264.263003179553;4960.263907632327;5109.795608175677;5116.590672746181;5127;5136.820211292606;4099.897502562438;4118.196951594426;4123.237201117788;4123.3196522573735;4134.780239829258;3846.2307538492273;3888.241792850395;4061.8984525386804;4111.506619205699;4134.441850350195;4071.816768245436;4072.4705788247634;4078.4086307485395;4081.163361510898;4098.303288440958;4068.7965601719798;4077.368007958771;4081.795910204478;4085.7140000199997;4089.386592011207;3645.981770091159;3646.161382881952;3658.871939482132;3680.245549662313;3680.300742858875;4873.34209881665;4964.35463389757;4967.950320496785;4976.6609693444025;4991.50084991498;4579.412631862987;4596.241620132674;4601.976990115061;4602.332661764059;4615.423072115986;5304.92042619361;5310.36275646921;5315.893682126374;5322.1484562470205;5353.634823120118;3851.5185601799776;3920.137569734654;3925.60743925608;3929.4302326162833;3934.783586902719;5469;5493;5502.889942201174;5507.256520369779;5546.972265138689;4067.2272268268935;4073.9388909166387;4084.7957602119777;4085.5097388312997;4113.321301985199;4053.64202992001;4093.8567150150197;4105.97947010263;4106.650934670586;4148.979255103705;4590;4599.436191694773;4627.8611641650805;4628.583427491474;4636.35091087248;5384.757685904144;5390.21841832932;5406.702631355313;5415.404305526389;5463.590230732711;1284.991281843748;1310.8885744711615;1407.4236854722571;1414.3140576820233;1425.8289005319427;896.2964073202505;898.205088496672;902.3953950852945;910.3809409601535;915.5239275576796;4529.686390946655;4561.908761824745;4567.680262381601;4600.35595016698;4604.286335617918;4748.596369308648;4780.084148669309;4816.927746083811;4826.444958829709;4836.56470917612;4530.79611417487;4567.885802854888;4598.517155698671;4604.815807367668;4607.470140933836;2393.940151496192;2542.694876614818;2563.2310306907852;2582.2511471673006;2589.8446093234465;4851.442084160296;4866.732329721828;4895.33912921751;4895.363602731693;4909.306289330176;4810.230363141881;4863.392075990501;4913.754312284372;4919.401194611765;4926.645172577498;5262.842114736564;5645.23789288449;5654.660720356792;5664.320281566156;5677.460641239159;5569.303837020372;5581.609287350009;5583.218349431002;5585.804496842591;5615.522680572197;5296.523312901857;5522.895420915753;5557.610597350662;5572.693501857437;5575.386707462257;5652.519535839499;5667;5689.857753556194;5694.572907032072;5706;3982.4225487304757;4010.238054769701;4049.93925091118;4051.291024070717;4057.350823868167;5293.364796224478;5337.706426146599;5582.302212223472;5646.491815736604;5655;5249.527542521191;5287.550558202596;5326.600504962066;5395.406505284494;5404.378496472798;5388.8444622151455;5403.729813509387;5418.349798024262;5435.701036443033;5448.237246785374;5323.733813309242;5396.406395296593;5419.4038655747045;5425.663217121521;5426.213199086189;5423.511883930308;5440.428754980829;5453.509184173444;5471.425500322568;5473.17902314656;5291.814786482455;5316.175992721134;5321.787128514816;5325.961437519802;5337.599680024091 01:45:15 INFO - PROCESS | 7274 | |5;yui.html;706.8197609609549;708.9468289878254;717.8061923280711;752.337942610503;786.1313248860009;15490.767638485431;17112.657746845056;17119.40082097127;17124;17128.229229684646;15346.769798453004;15423.305951232194;15424.151671658054;15512.922435387807;15518.534443966671;645.4094503529288;653.7940548727136;752.9548227106363;769.9422543309246;771.4021633234232;773.6905237904855;778.4278555261878;778.4784194589638;778.8559116563425;779.2441331908068;809.6316176139842;812.9390295727815;813.6541969662899;815.2092470303826;815.559597817178;675.1661697803185;691.1464341538197;800.2717527050414;811.1320886651285;812.9552874591895;591.3760982163816;591.4174538079988;591.6450129922056;592.0940960330657;597.922270104888;14737.926310368486;14768.778468322984;14792.482263120739;14793.186374749384;14821.481248156262;13663.863361366359;13685;13956.2324072176;14114.082584631966;14351.928240358835;13155.539556115586;13262.3368831559;13501.324933753272;13553.728925421436;13558.593242202749;4369.715968462072;4374.387585737967;4392.099619577979;4392.714473559208;4406.206882761102;74947.62526187388;78294.60852695757;78417;79372;80750;11100.722481938015;11124.944375278234;11142.27575207609;11260.099192064616;11494.597689080842;21550.461238469165;21615.45961350979;21683.56632867334;21686.566268674538;22248.77751222467;8249.587520624065;8263.504189748513;8278.793030174294;8341.83316333682;8454.957725211334;4434.423524941802;4438.800253988578;4499.775011249424;4518.932216016762;4547.045120524661;3527.5414196154334;3633.8364773585254;3635.127569383382;3636.127329440915;3665.065408320861;632.8512799492115;636.5098873867189;639.8432384065934;657.0735263278849;660.1286302081206;624.9625022498574;633.3065293503606;642.2164958750317;663.3333499832734;666.8399584099781;8760.474371537728;8928.553572321358;9203.723888283363;9244;9308.348415610977;551.6497024389462;626.4017862940881;650.9576877503042;657.5167252069725;665.1585744033705;4526.140033393644;4559.498455169929;4589.10512450069;4608;4617.492075871652;114259;115903.42048289704;118122.40938795423;119265.40367298108;125754.37122814327;81155.5942220285;83752;94675.52662236782;109802.45098774455;109967.45016274868;65550.67224663941;81058;83790.58104709437;84296.57851710702;84552.57723711342;9363.204127649225;9528.475933823705;10101.242406819665;10107.39355638664;10118.08937195656;50364.74817625889;50424.24363634622;50566;51602.74198628983;51872;66908.6654566724;67048.99426508509;73893;75557;78258.21741782509;12419.503219871103;12798.552050678181;12833.42249598789;12934.870651293366;13286.476584899896;14108.36512356926;14370.856291436952;14729.55811325662;14866.405343786128;15030.549083527512;13482.865171348161;13685.726285474433;14321.28393580296;14551.126932383668;14791.92604036973;13641.386137623633;13708.86291137076;14050.859491405365;14111.717765644835;14644.341004654603;13106.279154646585;13327.400266987815;13959.162450253018;14012;14439.78340324917;10576;11003.724906877393;11307.886921130683;11367.48846301935;11474.541018359507;9724.854127188239;10206.285560010729;10873.891261087289;11631.752482841584;11748.29510229389 01:45:15 INFO - PROCESS | 7274 | __end_tp_report 01:45:15 INFO - PROCESS | 7274 | __start_cc_report 01:45:15 INFO - PROCESS | 7274 | _x_x_mozilla_cycle_collect,2380 01:45:15 INFO - PROCESS | 7274 | __end_cc_report 01:45:15 INFO - PROCESS | 7274 | __startTimestamp1475829915739__endTimestamp 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | ------- Summary: start ------- 01:45:15 INFO - PROCESS | 7274 | Number of tests: 6 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | [#0] dojo.html Cycles:165 Average:5089.97 Median:5234.06 stddev:536.98 (10.3%) stddev-sans-first:512.64 01:45:15 INFO - PROCESS | 7274 | Values: 2986.0 3015.2 3016.8 3037.9 3059.3 5045.6 5126.5 5137.4 5219.5 5219.7 5081.5 5110.4 5123.4 5125.5 5154.3 4745.4 4763.0 4764.3 4788.0 4788.9 4727.5 4738.6 4784.2 4793.2 4805.3 4783.1 4795.3 4808.4 4817.4 4863.0 4652.6 4683.3 4779.7 4790.3 4813.3 4631.5 4663.6 4666.7 4721.6 4735.6 5020.6 5022.5 5073.8 5109.8 5125.5 5472.3 5476.6 5477.0 5482.2 5546.8 5396.4 5450.5 5507.9 5508.2 5527.0 5127.4 5147.2 5168.7 5172.6 5193.0 5621.6 5627.2 5632.1 5633.7 5697.0 5305.5 5326.3 5404.7 5408.7 5456.6 5538.8 5550.3 5552.8 5605.3 5620.3 5518.9 5521.6 5527.6 5532.6 5590.5 5353.9 5355.9 5408.4 5525.3 5530.0 4187.7 4233.5 4278.5 4281.7 4283.1 3770.2 3833.3 3840.6 3845.8 3869.4 5100.2 5119.7 5126.2 5126.5 5178.7 5398.6 5398.8 5400.3 5414.4 5450.5 5159.9 5209.4 5218.3 5223.5 5271.2 4745.2 4751.4 4753.5 4764.2 4785.6 5440.1 5548.7 5575.3 5587.2 5623.8 5321.0 5358.8 5375.8 5379.0 5383.5 5412.5 5448.4 5450.2 5450.4 5452.6 5227.5 5261.6 5262.3 5270.7 5293.2 5354.1 5362.4 5368.6 5369.4 5375.5 5229.7 5234.1 5238.7 5239.0 5240.1 5225.6 5227.7 5227.9 5230.6 5311.9 5260.5 5350.5 5353.7 5358.1 5359.2 5415.4 5433.1 5434.9 5495.1 5501.4 5146.3 5184.9 5272.8 5338.2 5348.7 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | [#1] ext.html Cycles:180 Average:56619.96 Median:36439.23 stddev:106610.28 (292.6%) stddev-sans-first:106826.37 01:45:15 INFO - PROCESS | 7274 | Values: 595.6 612.6 615.1 619.9 632.3 42438.0 43306.8 43989.3 44332.3 48421.3 44767.6 44847.1 45310.0 45384.1 45395.0 7692.7 7836.7 8756.9 8948.3 8959.8 10564.8 10817.8 10832.6 11226.9 11238.2 10876.0 10935.1 10954.5 10956.7 10964.8 10837.9 10887.9 10890.7 10891.9 10898.1 10609.1 10622.6 10698.8 10703.9 10708.1 42072.2 42276.8 42389.4 42556.8 42563.4 3399.0 3415.9 3456.0 3778.7 3857.7 31693.8 31798.4 31980.0 31995.7 33388.3 4269.3 4455.3 4501.2 4564.3 4630.6 349831.0 350360.0 350402.0 352460.0 354207.0 59490.0 59566.0 59867.0 59916.7 59953.0 36303.8 36842.4 36904.3 39054.4 61708.4 16945.5 17092.4 17107.9 17111.5 17122.8 11994.9 12260.9 12797.4 12982.8 13048.9 18990.6 19137.3 19190.6 19229.9 19294.5 7091.2 7134.6 7175.7 7178.2 7275.9 921.3 1058.3 1089.2 1133.8 1142.1 31422.2 31613.0 31664.5 31756.8 32237.7 1094.1 1117.6 1117.7 1131.4 1138.2 15966.0 17130.1 17132.5 17159.8 17227.3 477678.0 479103.0 480992.0 481777.0 481903.0 58481.0 59023.4 59044.0 59069.7 59084.7 1210.7 1251.2 1300.2 1335.6 1339.5 29637.3 32491.7 32762.8 32799.8 33394.5 49961.3 50638.2 50665.7 50678.0 50686.7 367294.0 368856.0 368985.0 369055.0 369250.0 27924.0 29091.4 29094.3 29108.4 29125.0 46419.3 47088.5 47351.5 47569.5 47615.5 39492.0 40057.6 40065.8 41271.2 41600.8 39729.0 40044.8 40118.0 41357.9 42151.0 39516.8 39816.6 40878.2 41262.0 41413.8 33299.8 36067.1 36159.3 36574.6 36969.2 27282.6 27508.3 27818.0 27988.6 28109.0 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | [#2] jquery.html Cycles:180 Average:27754.05 Median:367.00 stddev:74485.64 (20295.7%) stddev-sans-first:74666.20 01:45:15 INFO - PROCESS | 7274 | Values: 366.4 367.6 380.0 388.3 400.9 14344.9 17734.6 18092.0 18156.5 18306.5 17083.7 17269.7 17305.1 17453.5 17824.7 4871.4 5093.4 5123.1 5200.7 5213.9 3846.9 4034.3 5237.0 5272.8 5481.0 5745.4 5778.9 5781.0 5786.8 5794.4 5607.1 5772.4 5820.4 5845.3 5851.2 5690.9 5694.3 5694.7 5695.8 5699.6 21513.2 22047.3 22175.3 23222.5 23488.4 2223.5 2362.0 2523.3 2645.8 2847.7 9281.3 9735.8 10051.1 10208.4 10224.3 1785.8 1857.0 1877.3 1938.7 1979.2 74274.0 79440.0 79861.0 80003.8 86009.1 10628.9 10788.2 10996.6 11201.0 11335.9 15670.3 15681.8 15694.3 15721.0 15752.4 8150.3 8359.9 8384.3 8471.0 8552.7 7772.2 7935.8 8228.9 8357.5 8412.9 4649.3 4752.6 4785.9 4800.3 4880.0 1938.2 1962.9 1999.5 2000.2 2021.4 914.8 931.9 946.0 946.6 977.1 18522.4 19641.9 19761.6 19800.2 19832.6 970.6 998.2 999.2 1015.6 1028.5 10266.0 10887.2 10934.2 10940.8 11005.2 443860.0 445985.0 448180.0 456096.0 457087.0 87694.1 91175.5 91732.0 92131.5 92165.5 1005.4 1007.1 1033.8 1048.1 1071.1 16283.2 16821.8 17037.8 17361.2 17683.2 41714.4 42481.0 42787.6 42924.4 42934.8 59022.0 59298.4 59593.4 60053.7 60829.7 8302.5 8317.3 8398.2 8490.7 8554.4 12743.7 13129.0 13245.3 13249.7 13399.9 11572.2 11596.1 11841.8 11865.2 12198.5 11292.9 11426.8 11467.7 11673.8 12051.2 11457.0 11546.2 11660.6 11718.2 12005.2 8423.8 8515.4 8577.8 8753.4 8796.4 10284.4 11137.7 11207.2 11223.4 11616.8 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | [#3] mootools.html Cycles:180 Average:5764.99 Median:4376.44 stddev:3454.36 (78.9%) stddev-sans-first:3447.21 01:45:15 INFO - PROCESS | 7274 | Values: 1225.4 1421.1 1473.5 1583.7 1764.3 7679.8 8701.9 8972.5 9000.5 9231.6 9025.1 9087.7 9098.4 9100.1 9104.1 2311.9 2342.2 2345.9 2346.1 2346.3 2202.4 2233.5 2261.3 2263.2 2263.5 2244.7 2278.8 2283.7 2284.5 2292.2 2224.5 2228.5 2243.5 2248.4 2249.6 2189.1 2190.7 2192.6 2196.3 2199.4 8703.6 8954.4 9039.9 9068.2 9083.2 5163.1 5368.6 5368.9 5369.7 5378.4 3393.8 3397.4 3430.7 3464.3 3497.3 1081.3 1103.5 1120.6 1165.1 1173.0 12582.5 12735.1 12800.2 12823.2 12832.2 4388.5 4415.0 4583.9 4585.6 4620.0 10033.8 10051.1 10053.8 10063.3 10070.8 5290.5 5291.3 5294.5 5296.1 5301.3 4364.3 4509.9 4790.1 4901.2 4941.5 3688.4 3722.9 3839.3 3865.5 3867.8 1075.3 1101.8 1105.1 1116.5 1117.2 834.2 847.4 847.5 878.7 888.8 5223.3 5279.2 5358.3 5379.2 5471.1 418.1 420.2 423.6 425.6 431.0 3507.8 3537.6 3546.4 3552.0 3603.7 11119.8 11481.2 11570.1 11584.3 11587.9 11288.5 11489.1 11507.4 11515.8 11516.5 8340.5 8346.6 8451.8 8454.3 8461.8 5289.9 5342.7 5413.6 5503.9 5621.3 10034.0 10213.3 10234.8 10235.8 10315.0 10232.8 10382.5 10566.4 10617.1 10756.8 6329.4 6485.2 6501.0 7431.3 7513.9 8616.8 8969.2 9002.5 9011.3 9022.3 7592.5 7633.5 7753.2 7920.6 7922.6 7620.4 7696.8 7739.0 7825.6 7826.5 6848.0 6939.0 6946.9 6947.9 6959.5 4997.5 5062.4 5065.9 5116.5 5313.6 4725.1 4737.1 4822.7 5006.4 5070.4 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | [#4] prototype.html Cycles:180 Average:4455.96 Median:4895.35 stddev:1295.16 (26.5%) stddev-sans-first:1260.98 01:45:15 INFO - PROCESS | 7274 | Values: 316.5 325.4 328.0 331.5 333.1 5047.4 5191.8 5214.3 5260.3 5264.3 4960.3 5109.8 5116.6 5127.0 5136.8 4099.9 4118.2 4123.2 4123.3 4134.8 3846.2 3888.2 4061.9 4111.5 4134.4 4071.8 4072.5 4078.4 4081.2 4098.3 4068.8 4077.4 4081.8 4085.7 4089.4 3646.0 3646.2 3658.9 3680.2 3680.3 4873.3 4964.4 4968.0 4976.7 4991.5 4579.4 4596.2 4602.0 4602.3 4615.4 5304.9 5310.4 5315.9 5322.1 5353.6 3851.5 3920.1 3925.6 3929.4 3934.8 5469.0 5493.0 5502.9 5507.3 5547.0 4067.2 4073.9 4084.8 4085.5 4113.3 4053.6 4093.9 4106.0 4106.7 4149.0 4590.0 4599.4 4627.9 4628.6 4636.4 5384.8 5390.2 5406.7 5415.4 5463.6 1285.0 1310.9 1407.4 1414.3 1425.8 896.3 898.2 902.4 910.4 915.5 4529.7 4561.9 4567.7 4600.4 4604.3 4748.6 4780.1 4816.9 4826.4 4836.6 4530.8 4567.9 4598.5 4604.8 4607.5 2393.9 2542.7 2563.2 2582.3 2589.8 4851.4 4866.7 4895.3 4895.4 4909.3 4810.2 4863.4 4913.8 4919.4 4926.6 5262.8 5645.2 5654.7 5664.3 5677.5 5569.3 5581.6 5583.2 5585.8 5615.5 5296.5 5522.9 5557.6 5572.7 5575.4 5652.5 5667.0 5689.9 5694.6 5706.0 3982.4 4010.2 4049.9 4051.3 4057.4 5293.4 5337.7 5582.3 5646.5 5655.0 5249.5 5287.6 5326.6 5395.4 5404.4 5388.8 5403.7 5418.3 5435.7 5448.2 5323.7 5396.4 5419.4 5425.7 5426.2 5423.5 5440.4 5453.5 5471.4 5473.2 5291.8 5316.2 5321.8 5326.0 5337.6 01:45:15 INFO - PROCESS | 7274 | 01:45:15 INFO - PROCESS | 7274 | [#5] yui.html Cycles:180 Average:20707.47 Median:4469.29 stddev:29745.09 (665.5%) stddev-sans-first:29790.62 01:45:15 INFO - PROCESS | 7274 | Values: 706.8 708.9 717.8 752.3 786.1 15490.8 17112.7 17119.4 17124.0 17128.2 15346.8 15423.3 15424.2 15512.9 15518.5 645.4 653.8 753.0 769.9 771.4 773.7 778.4 778.5 778.9 779.2 809.6 812.9 813.7 815.2 815.6 675.2 691.1 800.3 811.1 813.0 591.4 591.4 591.6 592.1 597.9 14737.9 14768.8 14792.5 14793.2 14821.5 13663.9 13685.0 13956.2 14114.1 14351.9 13155.5 13262.3 13501.3 13553.7 13558.6 4369.7 4374.4 4392.1 4392.7 4406.2 74947.6 78294.6 78417.0 79372.0 80750.0 11100.7 11124.9 11142.3 11260.1 11494.6 21550.5 21615.5 21683.6 21686.6 22248.8 8249.6 8263.5 8278.8 8341.8 8455.0 4434.4 4438.8 4499.8 4518.9 4547.0 3527.5 3633.8 3635.1 3636.1 3665.1 632.9 636.5 639.8 657.1 660.1 625.0 633.3 642.2 663.3 666.8 8760.5 8928.6 9203.7 9244.0 9308.3 551.6 626.4 651.0 657.5 665.2 4526.1 4559.5 4589.1 4608.0 4617.5 114259.0 115903.4 118122.4 119265.4 125754.4 81155.6 83752.0 94675.5 109802.5 109967.5 65550.7 81058.0 83790.6 84296.6 84552.6 9363.2 9528.5 10101.2 10107.4 10118.1 50364.7 50424.2 50566.0 51602.7 51872.0 66908.7 67049.0 73893.0 75557.0 78258.2 12419.5 12798.6 12833.4 12934.9 13286.5 14108.4 14370.9 14729.6 14866.4 15030.5 13482.9 13685.7 14321.3 14551.1 14791.9 13641.4 13708.9 14050.9 14111.7 14644.3 13106.3 13327.4 13959.2 14012.0 14439.8 10576.0 11003.7 11307.9 11367.5 11474.5 9724.9 10206.3 10873.9 11631.8 11748.3 01:45:15 INFO - PROCESS | 7274 | -------- Summary: end -------- 01:45:15 INFO - PROCESS | 7274 | 01:45:16 INFO - TEST-INFO | 7274: exit 0 01:45:16 INFO - TEST-OK | dromaeo_css | took 1119162ms 01:45:16 INFO - TEST-START | kraken 01:45:16 INFO - operating with platform_type : linux_ 01:45:16 INFO - Initialising browser for kraken test... 01:45:16 INFO - TEST-INFO | started process 7581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgOcMBD/profile http://localhost:41641/getInfo.html) 01:45:21 INFO - PROCESS | 7581 | __metrics Screen width/height:1600/1200 01:45:21 INFO - PROCESS | 7581 | colorDepth:24 01:45:21 INFO - PROCESS | 7581 | Browser inner width/height: 1024/697 01:45:21 INFO - PROCESS | 7581 | __metrics 01:45:21 INFO - PROCESS | 7581 | 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" 01:45:21 INFO - PROCESS | 7581 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:45:22 INFO - PROCESS | 7581 | console.error: PushService: 01:45:22 INFO - PROCESS | 7581 | stateChangeProcessEnqueue: Error transitioning state 01:45:22 INFO - PROCESS | 7581 | UnknownError 01:45:23 INFO - TEST-INFO | 7581: exit 0 01:45:23 INFO - Browser initialized. 01:45:23 INFO - Running cycle 1/1 for kraken test... 01:45:23 INFO - TEST-INFO | started process 7661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgOcMBD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:35 INFO - PROCESS | 7661 | RSS: Main: 173543424 01:45:35 INFO - PROCESS | 7661 | 01:45:37 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41641/tests/kraken/driver.html?testName=audio-beat-detection) 01:45:38 INFO - PROCESS | 7661 | RSS: Main: 232505344 01:45:38 INFO - PROCESS | 7661 | 01:45:41 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41641/tests/kraken/driver.html?testName=audio-dft) 01:45:41 INFO - PROCESS | 7661 | RSS: Main: 217886720 01:45:41 INFO - PROCESS | 7661 | 01:45:45 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41641/tests/kraken/driver.html?testName=audio-fft) 01:45:45 INFO - PROCESS | 7661 | RSS: Main: 300130304 01:45:45 INFO - PROCESS | 7661 | 01:45:47 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41641/tests/kraken/driver.html?testName=audio-oscillator) 01:45:48 INFO - PROCESS | 7661 | RSS: Main: 208482304 01:45:48 INFO - PROCESS | 7661 | 01:45:50 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:51 INFO - PROCESS | 7661 | RSS: Main: 213626880 01:45:51 INFO - PROCESS | 7661 | 01:45:54 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41641/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:54 INFO - PROCESS | 7661 | RSS: Main: 249536512 01:45:54 INFO - PROCESS | 7661 | 01:45:57 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41641/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:58 INFO - PROCESS | 7661 | RSS: Main: 248172544 01:45:58 INFO - PROCESS | 7661 | 01:46:01 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41641/tests/kraken/driver.html?testName=json-parse-financial) 01:46:01 INFO - PROCESS | 7661 | RSS: Main: 248594432 01:46:01 INFO - PROCESS | 7661 | 01:46:03 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:46:04 INFO - PROCESS | 7661 | RSS: Main: 210583552 01:46:04 INFO - PROCESS | 7661 | 01:46:05 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:06 INFO - PROCESS | 7661 | RSS: Main: 218034176 01:46:06 INFO - PROCESS | 7661 | 01:46:08 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:09 INFO - PROCESS | 7661 | RSS: Main: 226983936 01:46:09 INFO - PROCESS | 7661 | 01:46:11 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:12 INFO - PROCESS | 7661 | RSS: Main: 236339200 01:46:12 INFO - PROCESS | 7661 | 01:46:15 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:15 INFO - PROCESS | 7661 | RSS: Main: 232620032 01:46:15 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:41641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41641/tests/kraken/driver.html?testName=ai-astar) 01:46:17 INFO - PROCESS | 7661 | RSS: Main: 282583040 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | __start_tp_report 01:46:17 INFO - PROCESS | 7661 | _x_x_mozilla_page_load 01:46:17 INFO - PROCESS | 7661 | _x_x_mozilla_page_load_details 01:46:17 INFO - PROCESS | 7661 | |i|pagename|runs| 01:46:17 INFO - PROCESS | 7661 | |0;ai-astar;110;111;110;110;110;111;109;111;110;110 01:46:17 INFO - PROCESS | 7661 | |1;audio-beat-detection;145;124;126;177;125;123;131;126;168;127 01:46:17 INFO - PROCESS | 7661 | |2;audio-dft;159;161;159;160;160;161;161;161;161;162 01:46:17 INFO - PROCESS | 7661 | |3;audio-fft;75;75;76;106;79;75;75;75;102;75 01:46:17 INFO - PROCESS | 7661 | |4;audio-oscillator;81;82;115;82;82;82;102;83;82;111 01:46:17 INFO - PROCESS | 7661 | |5;imaging-gaussian-blur;117;116;117;116;116;116;116;117;117;117 01:46:17 INFO - PROCESS | 7661 | |6;imaging-darkroom;146;147;145;145;146;145;145;146;145;146 01:46:17 INFO - PROCESS | 7661 | |7;imaging-desaturate;95;96;97;95;95;95;95;95;95;96 01:46:17 INFO - PROCESS | 7661 | |8;json-parse-financial;54;52;51;59;51;54;53;53;54;54 01:46:17 INFO - PROCESS | 7661 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;62;62 01:46:17 INFO - PROCESS | 7661 | |10;stanford-crypto-aes;81;88;83;88;79;79;80;81;78;80 01:46:17 INFO - PROCESS | 7661 | |11;stanford-crypto-ccm;137;131;145;135;134;132;136;129;178;132 01:46:17 INFO - PROCESS | 7661 | |12;stanford-crypto-pbkdf2;168;165;170;168;172;166;166;166;166;163 01:46:17 INFO - PROCESS | 7661 | |13;stanford-crypto-sha256-iterative;65;67;66;66;67;64;64;64;67;66 01:46:17 INFO - PROCESS | 7661 | __end_tp_report 01:46:17 INFO - PROCESS | 7661 | __start_cc_report 01:46:17 INFO - PROCESS | 7661 | _x_x_mozilla_cycle_collect,1655 01:46:17 INFO - PROCESS | 7661 | __end_cc_report 01:46:17 INFO - PROCESS | 7661 | __startTimestamp1475829977854__endTimestamp 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | ------- Summary: start ------- 01:46:17 INFO - PROCESS | 7661 | Number of tests: 14 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 01:46:17 INFO - PROCESS | 7661 | Values: 110.0 111.0 110.0 110.0 110.0 111.0 109.0 111.0 110.0 110.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:129.00 stddev:19.75 (15.3%) stddev-sans-first:20.75 01:46:17 INFO - PROCESS | 7661 | Values: 145.0 124.0 126.0 177.0 125.0 123.0 131.0 126.0 168.0 127.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.87 01:46:17 INFO - PROCESS | 7661 | Values: 159.0 161.0 159.0 160.0 160.0 161.0 161.0 161.0 161.0 162.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:12.07 (16.1%) stddev-sans-first:12.58 01:46:17 INFO - PROCESS | 7661 | Values: 75.0 75.0 76.0 106.0 79.0 75.0 75.0 75.0 102.0 75.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:13.58 (16.6%) stddev-sans-first:13.99 01:46:17 INFO - PROCESS | 7661 | Values: 81.0 82.0 115.0 82.0 82.0 82.0 102.0 83.0 82.0 111.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:46:17 INFO - PROCESS | 7661 | Values: 117.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:46:17 INFO - PROCESS | 7661 | Values: 146.0 147.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 01:46:17 INFO - PROCESS | 7661 | Values: 95.0 96.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:2.27 (4.2%) stddev-sans-first:2.40 01:46:17 INFO - PROCESS | 7661 | Values: 54.0 52.0 51.0 59.0 51.0 54.0 53.0 53.0 54.0 54.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:46:17 INFO - PROCESS | 7661 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:3.59 (4.4%) stddev-sans-first:3.80 01:46:17 INFO - PROCESS | 7661 | Values: 81.0 88.0 83.0 88.0 79.0 79.0 80.0 81.0 78.0 80.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:135.50 stddev:14.43 (10.6%) stddev-sans-first:15.28 01:46:17 INFO - PROCESS | 7661 | Values: 137.0 131.0 145.0 135.0 134.0 132.0 136.0 129.0 178.0 132.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.00 stddev:2.58 (1.5%) stddev-sans-first:2.71 01:46:17 INFO - PROCESS | 7661 | Values: 168.0 165.0 170.0 168.0 172.0 166.0 166.0 166.0 166.0 163.0 01:46:17 INFO - PROCESS | 7661 | 01:46:17 INFO - PROCESS | 7661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 01:46:17 INFO - PROCESS | 7661 | Values: 65.0 67.0 66.0 66.0 67.0 64.0 64.0 64.0 67.0 66.0 01:46:17 INFO - PROCESS | 7661 | -------- Summary: end -------- 01:46:17 INFO - PROCESS | 7661 | 01:46:19 INFO - TEST-INFO | 7661: exit 0 01:46:19 INFO - TEST-OK | kraken | took 62471ms 01:46:19 INFO - SUITE-END | took 1181s 01:46:19 INFO - Completed test suite (00:19:42) 01:46:19 INFO - javascript benchmark 01:46:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2985.9999999999995, 3015.170828022294, 3016.7737419693512, 3037.863296151673, 3059.311654877653, 5045.646804723661, 5126.487351264872, 5137.409197942237, 5219.5041471060285, 5219.739013049351, 5081.491850814917, 5110.361204849394, 5123.385193776743, 5125.538701516863, 5154.278401023859, 4745.406824146981, 4762.97618511907, 4764.309175169598, 4788.018456216485, 4788.90422191556, 4727.479977202505, 4738.597219236369, 4784.186688263004, 4793.233082706767, 4805.303231031498, 4783.067301876135, 4795.280707893827, 4808.3508726322025, 4817.445993710733, 4863.0, 4652.55800698933, 4683.344331793552, 4779.737114458703, 4790.329353890458, 4813.302071199674, 4631.490536041033, 4663.580277774982, 4666.673332866701, 4721.622270218374, 4735.57379835813, 5020.59835213182, 5022.497750224985, 5073.822416215452, 5109.821156259513, 5125.4618265082, 5472.26124473195, 5476.644018138848, 5477.0, 5482.23248745176, 5546.77812887484, 5396.406395296514, 5450.482204190595, 5507.862303442446, 5508.228847961289, 5527.005139074965, 5127.359080115023, 5147.1507201312115, 5168.7415629218385, 5172.560332371715, 5193.0, 5621.606487545832, 5627.184058311604, 5632.070708333161, 5633.746481408347, 5696.971515142398, 5305.495977882095, 5326.334208223972, 5404.675719456845, 5408.675479471166, 5456.563474921997, 5538.75075621598, 5550.250716153349, 5552.750126244328, 5605.271314729059, 5620.297462817148, 5518.944810551923, 5521.585881058937, 5527.585431092684, 5532.557395408438, 5590.524805391506, 5353.946460535422, 5355.946440535623, 5408.378036525771, 5525.309336332958, 5530.0, 4187.706860519735, 4233.5131459881895, 4278.529361770203, 4281.678874084456, 4283.057727299989, 3770.1894092770185, 3833.252515759456, 3840.615938406193, 3845.750026248285, 3869.4195870619633, 5100.158473851847, 5119.667221630582, 5126.1798112302595, 5126.53861152498, 5178.663386879841, 5398.62209645321, 5398.757055932492, 5400.270963419966, 5414.35027796667, 5450.4549545045975, 5159.871003224949, 5209.426963034063, 5218.295530103387, 5223.4515375884985, 5271.156614941591, 4745.1695953208055, 4751.429828420612, 4753.524647535219, 4764.166270902579, 4785.59322457595, 5440.102383106743, 5548.722563871709, 5575.330960284792, 5587.189857470644, 5623.831285061373, 5321.0, 5358.839234822962, 5375.81184658535, 5378.973105134606, 5383.515483606494, 5412.512873841373, 5448.4006759257245, 5450.182472629137, 5450.373207081077, 5452.645578037414, 5227.451117632746, 5261.57907367402, 5262.26328314044, 5270.7101109439345, 5293.232481290114, 5354.089804733283, 5362.410134885082, 5368.624196306221, 5369.409364969928, 5375.5162035417, 5229.686218826882, 5234.057869583511, 5238.659487133325, 5239.0, 5240.082985477602, 5225.608079394136, 5227.712475813714, 5227.869303267449, 5230.555402790653, 5311.893762124813, 5260.526552610283, 5350.5184533392185, 5353.732313384237, 5358.115910874662, 5359.249705041219, 5415.431379705232, 5433.130699088127, 5434.918476222781, 5495.065838807493, 5501.422350653123, 5146.279520867157, 5184.948150518447, 5272.841814745564, 5338.225957236256, 5348.705821179872], "value": 5056.0802083051485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5920194666653, 612.6385432594768, 615.1234490850538, 619.9225096862892, 632.2886752403546, 42438.0, 43306.78346608266, 43989.34015989755, 44332.3350149748, 48421.27368089482, 44767.55232447683, 44847.103057938904, 45310.0, 45384.09231815362, 45395.04932179406, 7692.730754423596, 7836.686532538692, 8756.91243087569, 8948.284137269004, 8959.820803583925, 10564.788704225912, 10817.83773243402, 10832.566697332137, 11226.887731122706, 11238.157138214625, 10876.0, 10935.125189984821, 10954.507047182857, 10956.671299861016, 10964.780704385908, 10837.891621083807, 10887.945560272226, 10890.673279801618, 10891.945540272327, 10898.128149748001, 10609.098226650667, 10622.628208012682, 10698.839517407245, 10703.946480267627, 10708.089812365959, 42072.158556828996, 42276.78861605672, 42389.36415953733, 42556.78721606372, 42563.36154957678, 3399.0285634332026, 3415.9316813663836, 3455.9827200863833, 3778.7123908120184, 3857.691384689218, 31693.841530792197, 31798.364032719448, 31980.0, 31995.680043199503, 33388.33223335544, 4269.2744016922525, 4455.264881294583, 4501.212287849613, 4564.338170965225, 4630.583247507707, 349831.0, 350360.0, 350402.0, 352460.0, 354207.0, 59490.0, 59566.0, 59867.0, 59916.70041649764, 59953.0, 36303.818480907954, 36842.447363289575, 36904.26191476209, 39054.41418378727, 61708.38291617116, 16945.49163525096, 17092.40176593813, 17107.914460427866, 17111.486655400357, 17122.82877171237, 11994.88005119955, 12260.877391225973, 12797.360131993362, 12982.805257921138, 13048.934755326352, 18990.62018759617, 19137.330193443162, 19190.61618767617, 19229.90385048094, 19294.517637058903, 7091.219965803757, 7134.643267836587, 7175.677094530759, 7178.2103968563415, 7275.89086163708, 921.3412410126791, 1058.333250052462, 1089.1939964426267, 1133.82992551118, 1142.1388876517426, 31422.21444463861, 31613.0, 31664.525032124537, 31756.841215794237, 32237.677623223935, 1094.141099237095, 1117.580907159815, 1117.7429191285887, 1131.4286285425808, 1138.1805100327751, 15966.0, 17130.143492825307, 17132.486025419257, 17159.828401716073, 17227.31090756356, 477678.0, 479103.0, 480992.0, 481777.0, 481903.0, 58481.0, 59023.40976590179, 59044.0, 59069.704651476466, 59084.7045764777, 1210.6610149158073, 1251.1804767876872, 1300.1808860417875, 1335.6260247130624, 1339.4842985450477, 29637.2590685226, 32491.67508324981, 32762.83618581892, 32799.83600081984, 33394.49908251427, 49961.250581242035, 50638.2404263929, 50665.74667126641, 50678.0, 50686.746566266935, 367294.0, 368856.0, 368985.0, 369055.0, 369250.0, 27924.0, 29091.418171636873, 29094.27264318409, 29108.417831643674, 29125.0, 46419.30371044505, 47088.52911470841, 47351.52648473471, 47569.52430475651, 47615.523844762494, 39492.0, 40057.599424005384, 40065.799671001456, 41271.1745765077, 41600.79199603983, 39729.0, 40044.79977600093, 40118.0, 41357.93210339411, 42151.0, 39516.80241598774, 39816.60183398129, 40878.1824363517, 41262.0, 41413.792931035154, 33299.83350083234, 36067.0983225411, 36159.27681446409, 36574.63425365819, 36969.15154242223, 27282.590761138203, 27508.312292192855, 27818.0, 27988.58017129704, 28109.0], "value": 20243.61129582962, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3808164202496, 367.62508219259956, 379.9639034291743, 388.2661769256106, 400.8556919508976, 14344.856551434483, 17734.64530709385, 18092.0, 18156.45530634083, 18306.450806475812, 17083.743743843854, 17269.740953885703, 17305.13474326285, 17453.47639570815, 17824.73262901054, 4871.366722326093, 5093.363329583802, 5123.077845987721, 5200.6879587224885, 5213.86965325868, 3846.8845934622004, 4034.253663072326, 5236.973815130919, 5272.841814745564, 5481.0, 5745.396733343002, 5778.855528611797, 5780.9710951445395, 5786.768529258825, 5794.362620111784, 5607.130894711306, 5772.365039845614, 5820.35976042635, 5845.298564172326, 5851.180834683148, 5690.857728556778, 5694.259746233005, 5694.6867922264255, 5695.77216911323, 5699.57253206007, 21513.24703635381, 22047.33857984263, 22175.334739957827, 23222.53554928892, 23488.412789680224, 2223.499712564676, 2362.019761798869, 2523.3060908250195, 2645.761881430661, 2847.658281006272, 9281.30390220736, 9735.756606084833, 10051.095401413835, 10208.387496750145, 10224.335418197794, 1785.7767779027622, 1857.0, 1877.2866310801808, 1938.6510428122933, 1979.2379933725476, 74274.0, 79440.0, 79861.0, 80003.79984800659, 86009.13990860137, 10628.946855265674, 10788.190885683449, 10996.560137594566, 11201.039818031812, 11335.943320283512, 15670.294836732375, 15681.764773528406, 15694.293756780973, 15721.0, 15752.369905203892, 8150.3479721622125, 8359.916400835913, 8384.287335576422, 8471.0, 8552.700655477152, 7772.222777722182, 7935.841283174304, 8228.876566851503, 8357.498550087013, 8412.873806892901, 4649.256119021008, 4752.643551733634, 4785.928211076836, 4800.3279540864305, 4880.0, 1938.185961896007, 1962.9214831406869, 1999.4901300168656, 2000.2399088346335, 2021.4036859126593, 914.7987442762582, 931.9021502742114, 945.9952700236455, 946.6308139825474, 977.1352353167498, 18522.444326670222, 19641.901790490956, 19761.60476790485, 19800.207991680458, 19832.60334793325, 970.5972021611094, 998.1515711645044, 999.2305924438142, 1015.5531566111035, 1028.5268776362957, 10266.0, 10887.237893347548, 10934.21177599707, 10940.835887461695, 11005.17461190414, 443860.0, 445985.0, 448180.0, 456096.0, 457087.0, 87694.05376758061, 91175.54412227897, 91732.0, 92131.53934230286, 92165.5391723037, 1005.4470041477158, 1007.1137399088901, 1033.7674023344687, 1048.0724558765396, 1071.1163290285544, 16283.185840708155, 16821.831781682027, 17037.829621703626, 17361.218745156246, 17683.20425580826, 41714.37428438515, 42481.0, 42787.57212427836, 42924.35613465738, 42934.78532607317, 59022.0, 59298.40701592929, 59593.404065958784, 60053.69973150281, 60829.69585152046, 8302.54336011525, 8317.251447369767, 8398.202170793766, 8490.702825401082, 8554.401191916755, 12743.745125097632, 13129.0, 13245.27151006704, 13249.668758281121, 13399.866001339862, 11572.247803893057, 11596.130290228099, 11841.82237266459, 11865.169438139248, 12198.51205951752, 11292.887071129184, 11426.771464570827, 11467.655970320904, 11673.824892626788, 12051.216670916363, 11457.0, 11546.191766576596, 11660.591879284184, 11718.23831450953, 12005.219660722025, 8423.831523369376, 8515.40392172542, 8577.828443430972, 8753.387262891536, 8796.384253102222, 10284.434356110187, 11137.665870023913, 11207.159463040467, 11223.38271395081, 11616.767664646492], "value": 9081.574067350657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.442423697218, 1421.1331088036295, 1473.5358362115933, 1583.7386831172857, 1764.267828851027, 7679.846403071935, 8701.91298087019, 8972.461652300859, 9000.45997240166, 9231.584578693959, 9025.142611451902, 9087.681931132413, 9098.363114581982, 9100.089991000897, 9104.135107164826, 2311.9422014449606, 2342.2387723989686, 2345.906163753448, 2346.1436575649936, 2346.296111166643, 2202.3503066595395, 2233.5421238646118, 2261.332906792492, 2263.20787724296, 2263.5359751250953, 2244.6969659096058, 2278.8063014643776, 2283.748787633359, 2284.4745708487058, 2292.151903795598, 2224.510607666311, 2228.4874478869788, 2243.517643706603, 2248.415411992877, 2249.5838269920037, 2189.1243502598927, 2190.6823510591034, 2192.550527141932, 2196.3301193136085, 2199.3951663292564, 8703.56391195452, 8954.37319387643, 9039.909600903973, 9068.229200517964, 9083.22792562633, 5163.070647283487, 5368.62419630626, 5368.892622147574, 5369.6509726867625, 5378.386484054768, 3393.7963722176746, 3397.405454045532, 3430.6569343065494, 3464.3071385722956, 3497.3355062538035, 1081.3403823667556, 1103.4979084516526, 1120.5965852293168, 1165.0795871261694, 1173.049829637996, 12582.496700131984, 12735.108542402035, 12800.231986080866, 12823.166494177849, 12832.165909215964, 4388.539203383662, 4414.977925110354, 4583.931241031387, 4585.564371384713, 4620.0, 10033.849492257623, 10051.145652619463, 10053.79892402148, 10063.295569310225, 10070.798584028278, 5290.470952904679, 5291.259223708684, 5294.470552944752, 5296.099663057213, 5301.3373328333955, 4364.345348197732, 4509.932351014738, 4790.137775200497, 4901.191303434894, 4941.50584941503, 3688.354537955847, 3722.8696995605565, 3839.30892439358, 3865.4588357629955, 3867.7679339239735, 1075.3010543147018, 1101.8457415961773, 1105.082781291526, 1116.5031560955297, 1117.173291764105, 834.1616675241344, 847.4491580472742, 847.5042100371229, 878.6748902905965, 888.8044630181349, 5223.347081614798, 5279.1817268323475, 5358.33020872391, 5379.193121031798, 5471.06991811393, 418.071880425455, 420.21839378755493, 423.55949812194973, 425.58080290913426, 431.0, 3507.7544571880235, 3537.646235376493, 3546.3971124908826, 3551.982240088783, 3603.7117030637487, 11119.777604447865, 11481.196316257781, 11570.132240082028, 11584.304941703525, 11587.88412115885, 11288.492017859217, 11489.080873530098, 11507.367094809699, 11515.76968460626, 11516.481758320895, 8340.541270230196, 8346.582670866554, 8451.788705282417, 8454.28138608213, 8461.830763384698, 5289.894202116013, 5342.652727572696, 5413.648112872651, 5503.917441238465, 5621.304724966842, 10034.0, 10213.33613315132, 10234.795304094025, 10235.795284094127, 10315.0, 10232.795344092927, 10382.48087595602, 10566.366018038942, 10617.097546708308, 10756.838647420138, 6329.367063293634, 6485.156929599122, 6500.967495162494, 7431.331180193809, 7513.924860751323, 8616.827663446822, 8969.237614802554, 9002.504862232377, 9011.2790976723, 9022.278217742696, 7592.468527203043, 7633.5419874807685, 7753.1859154787935, 7920.643571039433, 7922.603869806602, 7620.428467865043, 7696.807579810549, 7738.961305193438, 7825.569593672175, 7826.491278066907, 6848.0, 6938.965305173442, 6946.930530694628, 6947.930520694728, 6959.512834101564, 4997.525235102659, 5062.392512898476, 5065.8733531662, 5116.4627714090975, 5313.601479889101, 4725.10223057618, 4737.147313483606, 4822.662413631012, 5006.424261210008, 5070.366204224472], "value": 4450.682531536245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.5346939998202, 325.3931417905606, 327.99469625597544, 331.4696485623003, 333.0607686324566, 5047.369078865142, 5191.792328306863, 5214.270002199691, 5260.2898608687865, 5264.263003179553, 4960.263907632327, 5109.795608175677, 5116.590672746181, 5127.0, 5136.820211292606, 4099.897502562438, 4118.196951594426, 4123.237201117788, 4123.3196522573735, 4134.780239829258, 3846.2307538492273, 3888.241792850395, 4061.8984525386804, 4111.506619205699, 4134.441850350195, 4071.816768245436, 4072.4705788247634, 4078.4086307485395, 4081.163361510898, 4098.303288440958, 4068.7965601719798, 4077.368007958771, 4081.795910204478, 4085.7140000199997, 4089.386592011207, 3645.981770091159, 3646.161382881952, 3658.871939482132, 3680.245549662313, 3680.300742858875, 4873.34209881665, 4964.35463389757, 4967.950320496785, 4976.6609693444025, 4991.50084991498, 4579.412631862987, 4596.241620132674, 4601.976990115061, 4602.332661764059, 4615.423072115986, 5304.92042619361, 5310.36275646921, 5315.893682126374, 5322.1484562470205, 5353.634823120118, 3851.5185601799776, 3920.137569734654, 3925.60743925608, 3929.4302326162833, 3934.783586902719, 5469.0, 5493.0, 5502.889942201174, 5507.256520369779, 5546.972265138689, 4067.2272268268935, 4073.9388909166387, 4084.7957602119777, 4085.5097388312997, 4113.321301985199, 4053.64202992001, 4093.8567150150197, 4105.97947010263, 4106.650934670586, 4148.979255103705, 4590.0, 4599.436191694773, 4627.8611641650805, 4628.583427491474, 4636.35091087248, 5384.757685904144, 5390.21841832932, 5406.702631355313, 5415.404305526389, 5463.590230732711, 1284.991281843748, 1310.8885744711615, 1407.4236854722571, 1414.3140576820233, 1425.8289005319427, 896.2964073202505, 898.205088496672, 902.3953950852945, 910.3809409601535, 915.5239275576796, 4529.686390946655, 4561.908761824745, 4567.680262381601, 4600.35595016698, 4604.286335617918, 4748.596369308648, 4780.084148669309, 4816.927746083811, 4826.444958829709, 4836.56470917612, 4530.79611417487, 4567.885802854888, 4598.517155698671, 4604.815807367668, 4607.470140933836, 2393.940151496192, 2542.694876614818, 2563.2310306907852, 2582.2511471673006, 2589.8446093234465, 4851.442084160296, 4866.732329721828, 4895.33912921751, 4895.363602731693, 4909.306289330176, 4810.230363141881, 4863.392075990501, 4913.754312284372, 4919.401194611765, 4926.645172577498, 5262.842114736564, 5645.23789288449, 5654.660720356792, 5664.320281566156, 5677.460641239159, 5569.303837020372, 5581.609287350009, 5583.218349431002, 5585.804496842591, 5615.522680572197, 5296.523312901857, 5522.895420915753, 5557.610597350662, 5572.693501857437, 5575.386707462257, 5652.519535839499, 5667.0, 5689.857753556194, 5694.572907032072, 5706.0, 3982.4225487304757, 4010.238054769701, 4049.93925091118, 4051.291024070717, 4057.350823868167, 5293.364796224478, 5337.706426146599, 5582.302212223472, 5646.491815736604, 5655.0, 5249.527542521191, 5287.550558202596, 5326.600504962066, 5395.406505284494, 5404.378496472798, 5388.8444622151455, 5403.729813509387, 5418.349798024262, 5435.701036443033, 5448.237246785374, 5323.733813309242, 5396.406395296593, 5419.4038655747045, 5425.663217121521, 5426.213199086189, 5423.511883930308, 5440.428754980829, 5453.509184173444, 5471.425500322568, 5473.17902314656, 5291.814786482455, 5316.175992721134, 5321.787128514816, 5325.961437519802, 5337.599680024091], "value": 4044.568486539341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.8197609609549, 708.9468289878254, 717.8061923280711, 752.337942610503, 786.1313248860009, 15490.767638485431, 17112.657746845056, 17119.40082097127, 17124.0, 17128.229229684646, 15346.769798453004, 15423.305951232194, 15424.151671658054, 15512.922435387807, 15518.534443966671, 645.4094503529288, 653.7940548727136, 752.9548227106363, 769.9422543309246, 771.4021633234232, 773.6905237904855, 778.4278555261878, 778.4784194589638, 778.8559116563425, 779.2441331908068, 809.6316176139842, 812.9390295727815, 813.6541969662899, 815.2092470303826, 815.559597817178, 675.1661697803185, 691.1464341538197, 800.2717527050414, 811.1320886651285, 812.9552874591895, 591.3760982163816, 591.4174538079988, 591.6450129922056, 592.0940960330657, 597.922270104888, 14737.926310368486, 14768.778468322984, 14792.482263120739, 14793.186374749384, 14821.481248156262, 13663.863361366359, 13685.0, 13956.2324072176, 14114.082584631966, 14351.928240358835, 13155.539556115586, 13262.3368831559, 13501.324933753272, 13553.728925421436, 13558.593242202749, 4369.715968462072, 4374.387585737967, 4392.099619577979, 4392.714473559208, 4406.206882761102, 74947.62526187388, 78294.60852695757, 78417.0, 79372.0, 80750.0, 11100.722481938015, 11124.944375278234, 11142.27575207609, 11260.099192064616, 11494.597689080842, 21550.461238469165, 21615.45961350979, 21683.56632867334, 21686.566268674538, 22248.77751222467, 8249.587520624065, 8263.504189748513, 8278.793030174294, 8341.83316333682, 8454.957725211334, 4434.423524941802, 4438.800253988578, 4499.775011249424, 4518.932216016762, 4547.045120524661, 3527.5414196154334, 3633.8364773585254, 3635.127569383382, 3636.127329440915, 3665.065408320861, 632.8512799492115, 636.5098873867189, 639.8432384065934, 657.0735263278849, 660.1286302081206, 624.9625022498574, 633.3065293503606, 642.2164958750317, 663.3333499832734, 666.8399584099781, 8760.474371537728, 8928.553572321358, 9203.723888283363, 9244.0, 9308.348415610977, 551.6497024389462, 626.4017862940881, 650.9576877503042, 657.5167252069725, 665.1585744033705, 4526.140033393644, 4559.498455169929, 4589.10512450069, 4608.0, 4617.492075871652, 114259.0, 115903.42048289704, 118122.40938795423, 119265.40367298108, 125754.37122814327, 81155.5942220285, 83752.0, 94675.52662236782, 109802.45098774455, 109967.45016274868, 65550.67224663941, 81058.0, 83790.58104709437, 84296.57851710702, 84552.57723711342, 9363.204127649225, 9528.475933823705, 10101.242406819665, 10107.39355638664, 10118.08937195656, 50364.74817625889, 50424.24363634622, 50566.0, 51602.74198628983, 51872.0, 66908.6654566724, 67048.99426508509, 73893.0, 75557.0, 78258.21741782509, 12419.503219871103, 12798.552050678181, 12833.42249598789, 12934.870651293366, 13286.476584899896, 14108.36512356926, 14370.856291436952, 14729.55811325662, 14866.405343786128, 15030.549083527512, 13482.865171348161, 13685.726285474433, 14321.28393580296, 14551.126932383668, 14791.92604036973, 13641.386137623633, 13708.86291137076, 14050.859491405365, 14111.717765644835, 14644.341004654603, 13106.279154646585, 13327.400266987815, 13959.162450253018, 14012.0, 14439.78340324917, 10576.0, 11003.724906877393, 11307.886921130683, 11367.48846301935, 11474.541018359507, 9724.854127188239, 10206.285560010729, 10873.891261087289, 11631.752482841584, 11748.29510229389], "value": 7471.05626511636, "unit": "score"}], "name": "dromaeo_css", "value": 7071.294736500989, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 109.0, 111.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 126.0, 177.0, 125.0, 123.0, 131.0, 126.0, 168.0, 127.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 106.0, 79.0, 75.0, 75.0, 75.0, 102.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 115.0, 82.0, 82.0, 82.0, 102.0, 83.0, 82.0, 111.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 59.0, 51.0, 54.0, 53.0, 53.0, 54.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 83.0, 88.0, 79.0, 79.0, 80.0, 81.0, 78.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 145.0, 135.0, 134.0, 132.0, 136.0, 129.0, 178.0, 132.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 170.0, 168.0, 172.0, 166.0, 166.0, 166.0, 166.0, 163.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 67.0, 64.0, 64.0, 64.0, 67.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1505.6000000000001, "alertThreshold": 2.0}]} 01:46:19 INFO - Return code: 0 01:46:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:46:19 INFO - # TBPL SUCCESS # 01:46:19 INFO - Running post-action listener: _resource_record_post_action 01:46:19 INFO - [mozharness: 2016-10-07 08:46:19.653909Z] Finished run-tests step (success) 01:46:19 INFO - Running post-run listener: _resource_record_post_run 01:46:19 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 339968; Write bytes: 404185088; Read time: 120; Write time: 313096 01:46:19 INFO - TinderboxPrint: CPU usage
13.1% 01:46:19 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 120 01:46:19 INFO - TinderboxPrint: I/O write bytes / time
404,185,088 / 313,096 01:46:19 INFO - TinderboxPrint: CPU idle
8,314.4 (86.9%) 01:46:19 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 01:46:19 INFO - TinderboxPrint: Swap in / out
0 / 0 01:46:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115351552; Read time: 0; Write time: 72804 01:46:19 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 335872; Write bytes: 288833536; Read time: 108; Write time: 240292 01:46:20 INFO - Running post-run listener: _upload_blobber_files 01:46:20 INFO - Blob upload gear active. 01:46:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:46:20 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 01:46:20 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:46:20 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:46:20 INFO - (blobuploader) - INFO - Open directory for files ... 01:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:24 INFO - (blobuploader) - INFO - Done attempting. 01:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:24 INFO - (blobuploader) - INFO - Done attempting. 01:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:25 INFO - (blobuploader) - INFO - Done attempting. 01:46:25 INFO - (blobuploader) - INFO - Iteration through files over. 01:46:25 INFO - Return code: 0 01:46:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:46:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:46:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b94c8eb6e84c6276ee08721cddd87d37c81f335c75447d59f39df519792fac1970cbe933551a06952ebc2a5ad8d85ec68229ce69404a02e2c634ba16ead3656d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1aa5b1c074edf0e9d65d9bdb4648fde27fadc867a18b87085a65b3f498d275e7d533b0bd7ea5ec48c67f55da67f4279e4ebcec303965e02b760cd7282bb5e1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca701938a0f467062ac80b49d5573c172bac301109a7227535cd8a65fc816d6233d01ed8ef8d3673ab57fae3646abac8f92287efb9e88cc10c152526db1bebd"} 01:46:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:46:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:46:25 INFO - Contents: 01:46:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b94c8eb6e84c6276ee08721cddd87d37c81f335c75447d59f39df519792fac1970cbe933551a06952ebc2a5ad8d85ec68229ce69404a02e2c634ba16ead3656d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1aa5b1c074edf0e9d65d9bdb4648fde27fadc867a18b87085a65b3f498d275e7d533b0bd7ea5ec48c67f55da67f4279e4ebcec303965e02b760cd7282bb5e1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca701938a0f467062ac80b49d5573c172bac301109a7227535cd8a65fc816d6233d01ed8ef8d3673ab57fae3646abac8f92287efb9e88cc10c152526db1bebd"} 01:46:25 INFO - Running post-run listener: copy_logs_to_upload_dir 01:46:25 INFO - Copying logs to upload dir... 01:46:25 INFO - mkdir: /builds/slave/test/build/upload/logs 01:46:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.576090 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-07 01:46:25.487590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:25.488381) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320 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/sha512/b94c8eb6e84c6276ee08721cddd87d37c81f335c75447d59f39df519792fac1970cbe933551a06952ebc2a5ad8d85ec68229ce69404a02e2c634ba16ead3656d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1aa5b1c074edf0e9d65d9bdb4648fde27fadc867a18b87085a65b3f498d275e7d533b0bd7ea5ec48c67f55da67f4279e4ebcec303965e02b760cd7282bb5e1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca701938a0f467062ac80b49d5573c172bac301109a7227535cd8a65fc816d6233d01ed8ef8d3673ab57fae3646abac8f92287efb9e88cc10c152526db1bebd"} build_url:https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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/sha512/b94c8eb6e84c6276ee08721cddd87d37c81f335c75447d59f39df519792fac1970cbe933551a06952ebc2a5ad8d85ec68229ce69404a02e2c634ba16ead3656d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1aa5b1c074edf0e9d65d9bdb4648fde27fadc867a18b87085a65b3f498d275e7d533b0bd7ea5ec48c67f55da67f4279e4ebcec303965e02b760cd7282bb5e1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca701938a0f467062ac80b49d5573c172bac301109a7227535cd8a65fc816d6233d01ed8ef8d3673ab57fae3646abac8f92287efb9e88cc10c152526db1bebd"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:25.544311) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:25.544659) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475826702.906254-108879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004779 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:25.594224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 01:46:25.594545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 01:46:25.594859) ========= ========= Total master_lag: 0.16 =========