builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1475361008.07 results: success (0) buildid: 20161001140155 builduid: f80e5b28e5fa4ab6b86efd293eb80da9 revision: 7c576fe3279d87543f0a03b844eba7bc215e17f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.071130) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.071894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.072175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.118353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.118823) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 15:30:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100K=0.1s 2016-10-01 15:30:10 (100 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.253128 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.393700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.393977) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022487 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.447228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:08.447536) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c576fe3279d87543f0a03b844eba7bc215e17f1 --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 7c576fe3279d87543f0a03b844eba7bc215e17f1 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 15:30:10,971 truncating revision to first 12 chars 2016-10-01 15:30:10,971 Setting DEBUG logging. 2016-10-01 15:30:10,971 attempt 1/10 2016-10-01 15:30:10,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c576fe3279d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 15:30:11,389 unpacking tar archive at: mozilla-central-7c576fe3279d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747328 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:09.208352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:09.208658) ========= script_repo_revision: 7c576fe3279d87543f0a03b844eba7bc215e17f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:09.209063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:09.209328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 15:30:09.219047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-01 15:30:09.219341) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:11 INFO - MultiFileLogger online at 20161001 15:30:11 in /builds/slave/test 15:30:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:30:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:11 INFO - {'append_to_log': False, 15:30:11 INFO - 'base_work_dir': '/builds/slave/test', 15:30:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:30:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:11 INFO - 'branch': 'Firefox-Non-PGO', 15:30:11 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:11 INFO - 'config_files': ('talos/linux_config.py',), 15:30:11 INFO - 'default_actions': ('clobber', 15:30:11 INFO - 'read-buildbot-config', 15:30:11 INFO - 'download-and-extract', 15:30:11 INFO - 'populate-webroot', 15:30:11 INFO - 'create-virtualenv', 15:30:11 INFO - 'install', 15:30:11 INFO - 'run-tests'), 15:30:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:11 INFO - 'download_minidump_stackwalk': True, 15:30:11 INFO - 'download_symbols': 'ondemand', 15:30:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:11 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:11 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:11 INFO - 'installer_path': 'installer.exe', 15:30:11 INFO - 'log_level': 'info', 15:30:11 INFO - 'log_name': 'talos', 15:30:11 INFO - 'log_to_console': True, 15:30:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:11 INFO - 'opt_config_files': (), 15:30:11 INFO - 'pip_index': False, 15:30:11 INFO - 'sps_profile': False, 15:30:11 INFO - 'sps_profile_interval': 0, 15:30:11 INFO - 'suite': 'dromaeojs', 15:30:11 INFO - 'system_bits': '32', 15:30:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:11 INFO - 'title': 'talos-linux64-ix-069', 15:30:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:11 INFO - 'use_talos_json': True, 15:30:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:11 INFO - 'work_dir': 'build'} 15:30:11 INFO - [mozharness: 2016-10-01 22:30:11.844018Z] Running clobber step. 15:30:11 INFO - Running pre-action listener: _resource_record_pre_action 15:30:11 INFO - Running main action method: clobber 15:30:11 INFO - rmtree: /builds/slave/test/build 15:30:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:12 INFO - Running post-action listener: _resource_record_post_action 15:30:12 INFO - [mozharness: 2016-10-01 22:30:12.823052Z] Finished clobber step (success) 15:30:12 INFO - [mozharness: 2016-10-01 22:30:12.823153Z] Running read-buildbot-config step. 15:30:12 INFO - Running pre-action listener: _resource_record_pre_action 15:30:12 INFO - Running main action method: read_buildbot_config 15:30:12 INFO - Using buildbot properties: 15:30:12 INFO - { 15:30:12 INFO - "project": "", 15:30:12 INFO - "product": "firefox", 15:30:12 INFO - "script_repo_revision": "production", 15:30:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:30:12 INFO - "repository": "", 15:30:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:30:12 INFO - "buildid": "20161001140155", 15:30:12 INFO - "pgo_build": "False", 15:30:12 INFO - "basedir": "/builds/slave/test", 15:30:12 INFO - "buildnumber": 657, 15:30:12 INFO - "slavename": "talos-linux64-ix-069", 15:30:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:30:12 INFO - "platform": "ubuntu64_hw", 15:30:12 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:30:12 INFO - "branch": "mozilla-central", 15:30:12 INFO - "repo_path": "mozilla-central", 15:30:12 INFO - "revision": "7c576fe3279d87543f0a03b844eba7bc215e17f1", 15:30:12 INFO - "stage_platform": "linux64", 15:30:12 INFO - "builduid": "f80e5b28e5fa4ab6b86efd293eb80da9", 15:30:12 INFO - "slavebuilddir": "test" 15:30:12 INFO - } 15:30:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:30:12 INFO - Running post-action listener: _resource_record_post_action 15:30:12 INFO - [mozharness: 2016-10-01 22:30:12.825580Z] Finished read-buildbot-config step (success) 15:30:12 INFO - [mozharness: 2016-10-01 22:30:12.825669Z] Running download-and-extract step. 15:30:12 INFO - Running pre-action listener: _resource_record_pre_action 15:30:12 INFO - Running main action method: download_and_extract 15:30:12 INFO - mkdir: /builds/slave/test/build/tests 15:30: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')]} 15:30:12 INFO - trying https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:30:12 INFO - Downloading https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/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 15:30:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/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 15:30:13 INFO - Downloaded 1361 bytes. 15:30:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:30:13 INFO - Using the following test package requirements: 15:30:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:30:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:30:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'jsshell-linux-x86_64.zip'], 15:30:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:30:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:30:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:30:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:30:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:30:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:30:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:30:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:30:13 INFO - Fetch https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:30:13 INFO - Http code: 200 15:30:13 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 15:30:13 INFO - x-amz-cf-id: qSPiPJ8TWpZHGOx7DQSd5QH2lrdgXR4a0aBcQLfF1yYvKfMxsoa82g== 15:30:13 INFO - x-amz-version-id: N1KOrsHubRTpQe55aHHFSLcHG7hHV0lq 15:30:14 INFO - Expected file size: 20419727 15:30:14 INFO - Obtained file size: 20419727 15:30:18 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 15:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:30:18 INFO - Http code: 200 15:30:18 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 15:30:18 INFO - x-amz-cf-id: vF0W8WCk299vxavTaRSIRbng_Mez43l0fauflBj5UbxAe3TVD0UPmA== 15:30:18 INFO - x-amz-version-id: N1KOrsHubRTpQe55aHHFSLcHG7hHV0lq 15:30:19 INFO - Expected file size: 20419727 15:30:19 INFO - Obtained file size: 20419727 15:30:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:30:23 INFO - Fetch https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:30:24 INFO - Http code: 200 15:30:24 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 15:30:24 INFO - x-amz-cf-id: 5W4tZxR6gkzWFjr5R_dCkFOLVj-jCW5Y4ZEy5BqgopGDFGbqUHE_DA== 15:30:24 INFO - x-amz-version-id: _18.FCMUkwvGoQm6PnkbGnKW_xjnVrei 15:30:24 INFO - Expected file size: 14408522 15:30:24 INFO - Obtained file size: 14408522 15:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:24 INFO - trying https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:30:24 INFO - Downloading https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/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 15:30:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/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 15:30:25 INFO - Downloaded 55811685 bytes. 15:30:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:30:25 INFO - mkdir: /builds/slave/test/properties 15:30:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:25 INFO - Contents: 15:30:25 INFO - build_url:https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:30:26 INFO - Running post-action listener: _resource_record_post_action 15:30:26 INFO - Running post-action listener: set_extra_try_arguments 15:30:26 INFO - [mozharness: 2016-10-01 22:30:26.308999Z] Finished download-and-extract step (success) 15:30:26 INFO - [mozharness: 2016-10-01 22:30:26.309226Z] Running populate-webroot step. 15:30:26 INFO - Running pre-action listener: _resource_record_pre_action 15:30:26 INFO - Running main action method: populate_webroot 15:30:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:26 INFO - '--tppagecycles', 15:30:26 INFO - '7'], 15:30:26 INFO - 'tests': ['tsvgm']}}, 15:30:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:30:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:30:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:30:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:30:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['damp', 'tps']}, 15:30:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'tests': ['damp', 'tps']}, 15:30:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['dromaeo_dom']}, 15:30:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['basic_compositor_video']}, 15:30:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:30:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['a11yr', 15:30:26 INFO - 'ts_paint', 15:30:26 INFO - 'tpaint', 15:30:26 INFO - 'sessionrestore', 15:30:26 INFO - 'sessionrestore_no_auto_restore', 15:30:26 INFO - 'tabpaint']}, 15:30:26 INFO - 'other-e10s': {'tests': ['a11yr', 15:30:26 INFO - 'ts_paint', 15:30:26 INFO - 'tpaint', 15:30:26 INFO - 'sessionrestore', 15:30:26 INFO - 'sessionrestore_no_auto_restore', 15:30:26 INFO - 'tabpaint']}, 15:30:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:30:26 INFO - 'ts_paint', 15:30:26 INFO - 'tpaint', 15:30:26 INFO - 'sessionrestore', 15:30:26 INFO - 'sessionrestore_no_auto_restore', 15:30:26 INFO - 'tabpaint']}, 15:30:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:30:26 INFO - 'ts_paint', 15:30:26 INFO - 'tpaint', 15:30:26 INFO - 'sessionrestore', 15:30:26 INFO - 'sessionrestore_no_auto_restore', 15:30:26 INFO - 'tabpaint']}, 15:30:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['a11yr', 15:30:26 INFO - 'ts_paint', 15:30:26 INFO - 'tpaint', 15:30:26 INFO - 'sessionrestore', 15:30:26 INFO - 'sessionrestore_no_auto_restore', 15:30:26 INFO - 'tabpaint']}, 15:30:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['a11yr', 15:30:26 INFO - 'ts_paint', 15:30:26 INFO - 'tpaint', 15:30:26 INFO - 'sessionrestore', 15:30:26 INFO - 'sessionrestore_no_auto_restore', 15:30:26 INFO - 'tabpaint']}, 15:30:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['tsvgx', 15:30:26 INFO - 'tsvgr_opacity', 15:30:26 INFO - 'tart', 15:30:26 INFO - 'tscrollx', 15:30:26 INFO - 'cart']}, 15:30:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:30:26 INFO - 'tsvgr_opacity', 15:30:26 INFO - 'tart', 15:30:26 INFO - 'tscrollx', 15:30:26 INFO - 'cart']}, 15:30:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'talos_options': ['--disable-e10s'], 15:30:26 INFO - 'tests': ['tp5o']}, 15:30:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'tests': ['tp5o']}, 15:30:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'talos_options': ['--disable-e10s', 15:30:26 INFO - '--xperf_path', 15:30:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:26 INFO - 'tests': ['tp5n']}, 15:30:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:26 INFO - 'talos_options': ['--xperf_path', 15:30:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:26 INFO - 'tests': ['tp5n']}}, 15:30:26 INFO - 'talos.zip': {'path': '', 15:30:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:26 INFO - Running post-action listener: _resource_record_post_action 15:30:26 INFO - [mozharness: 2016-10-01 22:30:26.330694Z] Finished populate-webroot step (success) 15:30:26 INFO - [mozharness: 2016-10-01 22:30:26.330782Z] Running create-virtualenv step. 15:30:26 INFO - Running pre-action listener: _resource_record_pre_action 15:30:26 INFO - Running main action method: create_virtualenv 15:30:26 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:26 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 15:30:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:26 INFO - Using real prefix '/usr' 15:30:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:28 INFO - Installing pip.................done. 15:30:28 INFO - Return code: 0 15:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:30:29 INFO - Reading from file tmpfile_stdout 15:30:29 INFO - Output received: 15:30:29 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) 15:30:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30:29 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')]} 15:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:29 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')]} 15:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:29 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:29 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 15:30:29 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 15:30:29 INFO - Using env: {'DISPLAY': ':0', 15:30:29 INFO - 'HOME': '/home/cltbld', 15:30:29 INFO - 'LANG': 'en_US.UTF-8', 15:30:29 INFO - 'LANGUAGE': 'en_US:en', 15:30:29 INFO - 'LOGNAME': 'cltbld', 15:30:29 INFO - 'MAIL': '/var/mail/cltbld', 15:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:29 INFO - 'MOZ_NO_REMOTE': '1', 15:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:29 INFO - 'NO_EM_RESTART': '1', 15:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:29 INFO - 'PWD': '/builds/slave/test', 15:30:29 INFO - 'SHELL': '/bin/bash', 15:30:29 INFO - 'SHLVL': '1', 15:30:29 INFO - 'TERM': 'linux', 15:30:29 INFO - 'TMOUT': '86400', 15:30:29 INFO - 'USER': 'cltbld', 15:30:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:29 INFO - '_': '/tools/buildbot/bin/python'} 15:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:29 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 15:30:29 INFO - Cleaning up... 15:30:29 INFO - Return code: 0 15:30:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:30:29 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')]} 15:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:29 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')]} 15:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:29 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:29 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 15:30:29 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 15:30:29 INFO - Using env: {'DISPLAY': ':0', 15:30:29 INFO - 'HOME': '/home/cltbld', 15:30:29 INFO - 'LANG': 'en_US.UTF-8', 15:30:29 INFO - 'LANGUAGE': 'en_US:en', 15:30:29 INFO - 'LOGNAME': 'cltbld', 15:30:29 INFO - 'MAIL': '/var/mail/cltbld', 15:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:29 INFO - 'MOZ_NO_REMOTE': '1', 15:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:29 INFO - 'NO_EM_RESTART': '1', 15:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:29 INFO - 'PWD': '/builds/slave/test', 15:30:29 INFO - 'SHELL': '/bin/bash', 15:30:29 INFO - 'SHLVL': '1', 15:30:29 INFO - 'TERM': 'linux', 15:30:29 INFO - 'TMOUT': '86400', 15:30:29 INFO - 'USER': 'cltbld', 15:30:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:29 INFO - '_': '/tools/buildbot/bin/python'} 15:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:29 INFO - Downloading/unpacking psutil>=3.1.1 15:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:30:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:31 INFO - Installing collected packages: psutil 15:30:31 INFO - Running setup.py install for psutil 15:30:31 INFO - building 'psutil._psutil_linux' extension 15:30:31 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 15:30:31 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 15:30:31 INFO - building 'psutil._psutil_posix' extension 15:30:31 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 15:30:31 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 15:30:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:32 INFO - Successfully installed psutil 15:30:32 INFO - Cleaning up... 15:30:32 INFO - Return code: 0 15:30:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:30:32 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')]} 15:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:32 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')]} 15:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:32 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:32 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 15:30:32 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 15:30:32 INFO - Using env: {'DISPLAY': ':0', 15:30:32 INFO - 'HOME': '/home/cltbld', 15:30:32 INFO - 'LANG': 'en_US.UTF-8', 15:30:32 INFO - 'LANGUAGE': 'en_US:en', 15:30:32 INFO - 'LOGNAME': 'cltbld', 15:30:32 INFO - 'MAIL': '/var/mail/cltbld', 15:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:32 INFO - 'MOZ_NO_REMOTE': '1', 15:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:32 INFO - 'NO_EM_RESTART': '1', 15:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:32 INFO - 'PWD': '/builds/slave/test', 15:30:32 INFO - 'SHELL': '/bin/bash', 15:30:32 INFO - 'SHLVL': '1', 15:30:32 INFO - 'TERM': 'linux', 15:30:32 INFO - 'TMOUT': '86400', 15:30:32 INFO - 'USER': 'cltbld', 15:30:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:32 INFO - '_': '/tools/buildbot/bin/python'} 15:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:30:32 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 15:30:32 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 15:30:32 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 15:30:32 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 15:30:32 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 15:30:32 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 15:30:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:30:34 INFO - Installing collected packages: mozsystemmonitor 15:30:34 INFO - Running setup.py install for mozsystemmonitor 15:30:34 INFO - Successfully installed mozsystemmonitor 15:30:34 INFO - Cleaning up... 15:30:34 INFO - Return code: 0 15:30:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:30:34 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')]} 15:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:34 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')]} 15:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:34 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:34 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 15:30:34 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 15:30:34 INFO - Using env: {'DISPLAY': ':0', 15:30:34 INFO - 'HOME': '/home/cltbld', 15:30:34 INFO - 'LANG': 'en_US.UTF-8', 15:30:34 INFO - 'LANGUAGE': 'en_US:en', 15:30:34 INFO - 'LOGNAME': 'cltbld', 15:30:34 INFO - 'MAIL': '/var/mail/cltbld', 15:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:34 INFO - 'MOZ_NO_REMOTE': '1', 15:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:34 INFO - 'NO_EM_RESTART': '1', 15:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:34 INFO - 'PWD': '/builds/slave/test', 15:30:34 INFO - 'SHELL': '/bin/bash', 15:30:34 INFO - 'SHLVL': '1', 15:30:34 INFO - 'TERM': 'linux', 15:30:34 INFO - 'TMOUT': '86400', 15:30:34 INFO - 'USER': 'cltbld', 15:30:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:34 INFO - '_': '/tools/buildbot/bin/python'} 15:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:30:34 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 15:30:34 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 15:30:34 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 15:30:34 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 15:30:34 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 15:30:34 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 15:30:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:30:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:30:36 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 15:30:36 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 15:30:36 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 15:30:36 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 15:30:36 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 15:30:36 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 15:30:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:30:36 INFO - warning: no files found matching '*.txt' 15:30:36 INFO - no previously-included directories found matching 'build' 15:30:36 INFO - no previously-included directories found matching 'dist' 15:30:36 INFO - no previously-included directories found matching '.git*' 15:30:36 INFO - Installing collected packages: jsonschema, functools32 15:30:36 INFO - Running setup.py install for functools32 15:30:36 INFO - warning: no files found matching '*.txt' 15:30:36 INFO - no previously-included directories found matching 'build' 15:30:36 INFO - no previously-included directories found matching 'dist' 15:30:36 INFO - no previously-included directories found matching '.git*' 15:30:36 INFO - Successfully installed jsonschema functools32 15:30:36 INFO - Cleaning up... 15:30:36 INFO - Return code: 0 15:30:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:30:36 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')]} 15:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:36 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')]} 15:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:36 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:36 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 15:30:36 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 15:30:36 INFO - Using env: {'DISPLAY': ':0', 15:30:36 INFO - 'HOME': '/home/cltbld', 15:30:36 INFO - 'LANG': 'en_US.UTF-8', 15:30:36 INFO - 'LANGUAGE': 'en_US:en', 15:30:36 INFO - 'LOGNAME': 'cltbld', 15:30:36 INFO - 'MAIL': '/var/mail/cltbld', 15:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:36 INFO - 'MOZ_NO_REMOTE': '1', 15:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:36 INFO - 'NO_EM_RESTART': '1', 15:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:36 INFO - 'PWD': '/builds/slave/test', 15:30:36 INFO - 'SHELL': '/bin/bash', 15:30:36 INFO - 'SHLVL': '1', 15:30:36 INFO - 'TERM': 'linux', 15:30:36 INFO - 'TMOUT': '86400', 15:30:36 INFO - 'USER': 'cltbld', 15:30:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:36 INFO - '_': '/tools/buildbot/bin/python'} 15:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:30:37 INFO - Cleaning up... 15:30:37 INFO - Return code: 0 15:30:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:30:37 INFO - Using env: {'DISPLAY': ':0', 15:30:37 INFO - 'HOME': '/home/cltbld', 15:30:37 INFO - 'LANG': 'en_US.UTF-8', 15:30:37 INFO - 'LANGUAGE': 'en_US:en', 15:30:37 INFO - 'LOGNAME': 'cltbld', 15:30:37 INFO - 'MAIL': '/var/mail/cltbld', 15:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:37 INFO - 'MOZ_NO_REMOTE': '1', 15:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:37 INFO - 'NO_EM_RESTART': '1', 15:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:37 INFO - 'PWD': '/builds/slave/test', 15:30:37 INFO - 'SHELL': '/bin/bash', 15:30:37 INFO - 'SHLVL': '1', 15:30:37 INFO - 'TERM': 'linux', 15:30:37 INFO - 'TMOUT': '86400', 15:30:37 INFO - 'USER': 'cltbld', 15:30:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:37 INFO - '_': '/tools/buildbot/bin/python'} 15:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:30:37 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 15:30:37 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 15:30:37 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 15:30:37 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 15:30:37 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 15:30:37 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 15:30:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:30:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:30:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 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 15:30:39 INFO - Downloading docopt-0.6.1.tar.gz 15:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:30:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:30:40 INFO - Running setup.py install for blobuploader 15:30:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:30:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:30:40 INFO - Running setup.py install for requests 15:30:40 INFO - Running setup.py install for docopt 15:30:40 INFO - Successfully installed blobuploader requests docopt 15:30:40 INFO - Cleaning up... 15:30:40 INFO - Return code: 0 15:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:40 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')]} 15:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:40 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')]} 15:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:40 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:40 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 15:30:40 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 15:30:40 INFO - Using env: {'DISPLAY': ':0', 15:30:40 INFO - 'HOME': '/home/cltbld', 15:30:40 INFO - 'LANG': 'en_US.UTF-8', 15:30:40 INFO - 'LANGUAGE': 'en_US:en', 15:30:40 INFO - 'LOGNAME': 'cltbld', 15:30:40 INFO - 'MAIL': '/var/mail/cltbld', 15:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:40 INFO - 'MOZ_NO_REMOTE': '1', 15:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:40 INFO - 'NO_EM_RESTART': '1', 15:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:40 INFO - 'PWD': '/builds/slave/test', 15:30:40 INFO - 'SHELL': '/bin/bash', 15:30:40 INFO - 'SHLVL': '1', 15:30:40 INFO - 'TERM': 'linux', 15:30:40 INFO - 'TMOUT': '86400', 15:30:40 INFO - 'USER': 'cltbld', 15:30:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:40 INFO - '_': '/tools/buildbot/bin/python'} 15:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:40 INFO - Running setup.py (path:/tmp/pip-k5MyWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:40 INFO - Running setup.py (path:/tmp/pip-J4lWWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:41 INFO - Running setup.py (path:/tmp/pip-yNugIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:41 INFO - Running setup.py (path:/tmp/pip-DeaUhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:41 INFO - Running setup.py (path:/tmp/pip-fxZRZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:41 INFO - Running setup.py (path:/tmp/pip-3VrM4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:41 INFO - Running setup.py (path:/tmp/pip-PZeCyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:41 INFO - Running setup.py (path:/tmp/pip-RjXsSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:41 INFO - Running setup.py (path:/tmp/pip-KyLN2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:41 INFO - Running setup.py (path:/tmp/pip-6FxD6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:41 INFO - Running setup.py (path:/tmp/pip-pFphWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:41 INFO - Running setup.py (path:/tmp/pip-pa35pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:41 INFO - Running setup.py (path:/tmp/pip-mitTch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:41 INFO - Running setup.py (path:/tmp/pip-nqrNIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:41 INFO - Running setup.py (path:/tmp/pip-OaTlYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:41 INFO - Running setup.py (path:/tmp/pip-Cg1bqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:42 INFO - Running setup.py (path:/tmp/pip-4NUYKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:30:42 INFO - Running setup.py install for manifestparser 15:30:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Running setup.py install for mozcrash 15:30:42 INFO - Running setup.py install for mozdebug 15:30:42 INFO - Running setup.py install for mozdevice 15:30:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Running setup.py install for mozfile 15:30:42 INFO - Running setup.py install for mozhttpd 15:30:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Running setup.py install for mozinfo 15:30:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Running setup.py install for mozInstall 15:30:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:30:42 INFO - Running setup.py install for mozleak 15:30:42 INFO - Running setup.py install for mozlog 15:30:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:30:43 INFO - Running setup.py install for moznetwork 15:30:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:30:43 INFO - Running setup.py install for mozprocess 15:30:43 INFO - Running setup.py install for mozprofile 15:30:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:30:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:30:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:30:43 INFO - Running setup.py install for mozrunner 15:30:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:30:43 INFO - Running setup.py install for mozscreenshot 15:30:43 INFO - Running setup.py install for moztest 15:30:43 INFO - Running setup.py install for mozversion 15:30:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:30:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:30:43 INFO - Cleaning up... 15:30:43 INFO - Return code: 0 15:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:43 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')]} 15:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:43 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')]} 15:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:43 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:43 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 15:30:43 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 15:30:43 INFO - Using env: {'DISPLAY': ':0', 15:30:43 INFO - 'HOME': '/home/cltbld', 15:30:43 INFO - 'LANG': 'en_US.UTF-8', 15:30:43 INFO - 'LANGUAGE': 'en_US:en', 15:30:43 INFO - 'LOGNAME': 'cltbld', 15:30:43 INFO - 'MAIL': '/var/mail/cltbld', 15:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:43 INFO - 'MOZ_NO_REMOTE': '1', 15:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:43 INFO - 'NO_EM_RESTART': '1', 15:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:43 INFO - 'PWD': '/builds/slave/test', 15:30:43 INFO - 'SHELL': '/bin/bash', 15:30:43 INFO - 'SHLVL': '1', 15:30:43 INFO - 'TERM': 'linux', 15:30:43 INFO - 'TMOUT': '86400', 15:30:43 INFO - 'USER': 'cltbld', 15:30:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:43 INFO - '_': '/tools/buildbot/bin/python'} 15:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:44 INFO - Running setup.py (path:/tmp/pip-FAnLMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:44 INFO - Running setup.py (path:/tmp/pip-iO17AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:44 INFO - Running setup.py (path:/tmp/pip-4vVVEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:44 INFO - Running setup.py (path:/tmp/pip-6TJaS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:44 INFO - Running setup.py (path:/tmp/pip-WyBl4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:44 INFO - Running setup.py (path:/tmp/pip-i8Rv9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:44 INFO - Running setup.py (path:/tmp/pip-oEj3UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:44 INFO - Running setup.py (path:/tmp/pip-7Cqlwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:44 INFO - Running setup.py (path:/tmp/pip-QBNiWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:44 INFO - Running setup.py (path:/tmp/pip-QGJLuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:44 INFO - Running setup.py (path:/tmp/pip-tXQm8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:44 INFO - Running setup.py (path:/tmp/pip-drC3mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:44 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)) 15:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:45 INFO - Running setup.py (path:/tmp/pip-HSc6AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:45 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)) 15:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:45 INFO - Running setup.py (path:/tmp/pip-AKEGS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:45 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)) 15:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:45 INFO - Running setup.py (path:/tmp/pip-0y7KAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:45 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)) 15:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:45 INFO - Running setup.py (path:/tmp/pip-8QqnA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:45 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)) 15:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:45 INFO - Running setup.py (path:/tmp/pip-7YSql6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:45 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)) 15:30:45 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)) 15:30:45 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)) 15:30:45 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)) 15:30:45 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)) 15:30:45 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)) 15:30:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:30:45 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 15:30:45 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 15:30:45 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 15:30:45 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 15:30:45 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 15:30:45 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 15:30:47 INFO - Downloading blessings-1.6.tar.gz 15:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:30:47 INFO - Installing collected packages: blessings 15:30:47 INFO - Running setup.py install for blessings 15:30:47 INFO - Successfully installed blessings 15:30:47 INFO - Cleaning up... 15:30:47 INFO - Return code: 0 15:30:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:30:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:30:47 INFO - Reading from file tmpfile_stdout 15:30:47 INFO - Current package versions: 15:30:47 INFO - argparse == 1.2.1 15:30:47 INFO - blessings == 1.6 15:30:47 INFO - blobuploader == 1.2.4 15:30:47 INFO - docopt == 0.6.1 15:30:47 INFO - functools32 == 3.2.3-2 15:30:47 INFO - jsonschema == 2.5.1 15:30:47 INFO - manifestparser == 1.1 15:30:47 INFO - mozInstall == 1.12 15:30:47 INFO - mozcrash == 0.17 15:30:47 INFO - mozdebug == 0.1 15:30:47 INFO - mozdevice == 0.48 15:30:47 INFO - mozfile == 1.2 15:30:47 INFO - mozhttpd == 0.7 15:30:47 INFO - mozinfo == 0.9 15:30:47 INFO - mozleak == 0.1 15:30:47 INFO - mozlog == 3.4 15:30:47 INFO - moznetwork == 0.27 15:30:47 INFO - mozprocess == 0.23 15:30:47 INFO - mozprofile == 0.28 15:30:47 INFO - mozrunner == 6.12 15:30:47 INFO - mozscreenshot == 0.1 15:30:47 INFO - mozsystemmonitor == 0.3 15:30:47 INFO - moztest == 0.7 15:30:47 INFO - mozversion == 1.4 15:30:47 INFO - psutil == 3.1.1 15:30:47 INFO - requests == 1.2.3 15:30:47 INFO - wsgiref == 0.1.2 15:30:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:47 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')]} 15:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:47 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')]} 15:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:47 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:47 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 15:30:47 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 15:30:47 INFO - Using env: {'DISPLAY': ':0', 15:30:47 INFO - 'HOME': '/home/cltbld', 15:30:47 INFO - 'LANG': 'en_US.UTF-8', 15:30:47 INFO - 'LANGUAGE': 'en_US:en', 15:30:47 INFO - 'LOGNAME': 'cltbld', 15:30:47 INFO - 'MAIL': '/var/mail/cltbld', 15:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:47 INFO - 'MOZ_NO_REMOTE': '1', 15:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:47 INFO - 'NO_EM_RESTART': '1', 15:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:47 INFO - 'PWD': '/builds/slave/test', 15:30:47 INFO - 'SHELL': '/bin/bash', 15:30:47 INFO - 'SHLVL': '1', 15:30:47 INFO - 'TERM': 'linux', 15:30:47 INFO - 'TMOUT': '86400', 15:30:47 INFO - 'USER': 'cltbld', 15:30:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:47 INFO - '_': '/tools/buildbot/bin/python'} 15:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 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)) 15:30:47 INFO - Cleaning up... 15:30:47 INFO - Return code: 0 15:30:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:30:47 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')]} 15:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:47 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')]} 15:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:47 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 0x7f73c910ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', '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 15:30:47 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 15:30:47 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 15:30:47 INFO - Using env: {'DISPLAY': ':0', 15:30:47 INFO - 'HOME': '/home/cltbld', 15:30:47 INFO - 'LANG': 'en_US.UTF-8', 15:30:47 INFO - 'LANGUAGE': 'en_US:en', 15:30:47 INFO - 'LOGNAME': 'cltbld', 15:30:47 INFO - 'MAIL': '/var/mail/cltbld', 15:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:47 INFO - 'MOZ_NO_REMOTE': '1', 15:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:47 INFO - 'NO_EM_RESTART': '1', 15:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:47 INFO - 'PWD': '/builds/slave/test', 15:30:47 INFO - 'SHELL': '/bin/bash', 15:30:47 INFO - 'SHLVL': '1', 15:30:47 INFO - 'TERM': 'linux', 15:30:47 INFO - 'TMOUT': '86400', 15:30:47 INFO - 'USER': 'cltbld', 15:30:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:47 INFO - '_': '/tools/buildbot/bin/python'} 15:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:30:48 INFO - Cleaning up... 15:30:48 INFO - Return code: 0 15:30:48 INFO - Running post-action listener: _resource_record_post_action 15:30:48 INFO - Running post-action listener: _start_resource_monitoring 15:30:48 INFO - Starting resource monitoring. 15:30:48 INFO - [mozharness: 2016-10-01 22:30:48.238536Z] Finished create-virtualenv step (success) 15:30:48 INFO - [mozharness: 2016-10-01 22:30:48.238997Z] Running install step. 15:30:48 INFO - Running pre-action listener: _resource_record_pre_action 15:30:48 INFO - Running main action method: install 15:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:30:48 INFO - Reading from file tmpfile_stdout 15:30:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:30:48 INFO - Reading from file tmpfile_stdout 15:30:48 INFO - Output received: 15:30:48 INFO - Usage: mozinstall [options] installer 15:30:48 INFO - Options: 15:30:48 INFO - -h, --help show this help message and exit 15:30:48 INFO - -d DEST, --destination=DEST 15:30:48 INFO - Directory to install application into. [default: 15:30:48 INFO - "/builds/slave/test"] 15:30:48 INFO - --app=APP Application being installed. [default: firefox] 15:30:48 INFO - mkdir: /builds/slave/test/build/application 15:30:48 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'] 15:30:48 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 15:31:04 INFO - Reading from file tmpfile_stdout 15:31:04 INFO - Output received: 15:31:04 INFO - /builds/slave/test/build/application/firefox/firefox 15:31:04 INFO - Running post-action listener: _resource_record_post_action 15:31:04 INFO - [mozharness: 2016-10-01 22:31:04.673440Z] Finished install step (success) 15:31:04 INFO - [mozharness: 2016-10-01 22:31:04.673685Z] Running run-tests step. 15:31:04 INFO - Running pre-action listener: _resource_record_pre_action 15:31:04 INFO - Running main action method: run_tests 15:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:04 INFO - Python 2.7.3 15:31:04 INFO - Return code: 0 15:31:04 INFO - grabbing minidump binary from tooltool 15:31:04 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')]} 15:31:04 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 0x1e9af60>, '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 0x1e9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:04 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 15:31:04 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 15:31:04 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 15:31:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:04 INFO - Return code: 0 15:31:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:31:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:31:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 15:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 15:31:04 INFO - Using env: {'DISPLAY': ':0', 15:31:04 INFO - 'HOME': '/home/cltbld', 15:31:04 INFO - 'LANG': 'en_US.UTF-8', 15:31:04 INFO - 'LANGUAGE': 'en_US:en', 15:31:04 INFO - 'LOGNAME': 'cltbld', 15:31:04 INFO - 'MAIL': '/var/mail/cltbld', 15:31:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:04 INFO - 'MOZ_NO_REMOTE': '1', 15:31:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:04 INFO - 'NO_EM_RESTART': '1', 15:31:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:04 INFO - 'PWD': '/builds/slave/test', 15:31:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:04 INFO - 'SHELL': '/bin/bash', 15:31:04 INFO - 'SHLVL': '1', 15:31:04 INFO - 'TERM': 'linux', 15:31:04 INFO - 'TMOUT': '86400', 15:31:04 INFO - 'USER': 'cltbld', 15:31:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849', 15:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:04 INFO - '_': '/tools/buildbot/bin/python'} 15:31:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 15:31:04 INFO - mozversion application_buildid: 20161001140155 15:31:04 INFO - mozversion application_changeset: 7c576fe3279d87543f0a03b844eba7bc215e17f1 15:31:04 INFO - mozversion application_display_name: Nightly 15:31:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:04 INFO - mozversion application_name: Firefox 15:31:04 INFO - mozversion application_remotingname: firefox 15:31:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:31:04 INFO - mozversion application_vendor: Mozilla 15:31:04 INFO - mozversion application_version: 52.0a1 15:31:04 INFO - mozversion platform_buildid: 20161001140155 15:31:04 INFO - mozversion platform_changeset: 7c576fe3279d87543f0a03b844eba7bc215e17f1 15:31:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:31:04 INFO - mozversion platform_version: 52.0a1 15:31:04 INFO - using testdate: 1475361064 15:31:04 INFO - actual date: 1475361064 15:31:04 INFO - starting webserver on 'localhost:52967' 15:31:04 INFO - SUITE-START | Running 2 tests 15:31:04 INFO - TEST-START | dromaeo_css 15:31:04 INFO - operating with platform_type : linux_ 15:31:04 INFO - Initialising browser for dromaeo_css test... 15:31:04 INFO - TEST-INFO | started process 22518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwbFYHK/profile http://localhost:52967/getInfo.html) 15:31:09 INFO - PROCESS | 22518 | __metrics Screen width/height:1600/1200 15:31:09 INFO - PROCESS | 22518 | colorDepth:24 15:31:09 INFO - PROCESS | 22518 | Browser inner width/height: 1024/697 15:31:09 INFO - PROCESS | 22518 | __metrics 15:31:10 INFO - PROCESS | 22518 | 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" 15:31:10 INFO - PROCESS | 22518 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:31:11 INFO - PROCESS | 22518 | console.error: PushService: 15:31:11 INFO - PROCESS | 22518 | stateChangeProcessEnqueue: Error transitioning state 15:31:11 INFO - PROCESS | 22518 | UnknownError 15:31:11 INFO - TEST-INFO | 22518: exit 0 15:31:11 INFO - Browser initialized. 15:31:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:11 INFO - TEST-INFO | started process 22599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwbFYHK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:24 INFO - PROCESS | 22599 | RSS: Main: 175210496 15:31:24 INFO - PROCESS | 22599 | 15:32:14 INFO - PROCESS | 22599 | 1475361134883 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] 15:34:29 INFO - PROCESS | 22599 | Cycle 1(1): loaded http://localhost:52967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52967/tests/dromaeo/cssquery-ext.html) 15:34:30 INFO - PROCESS | 22599 | RSS: Main: 281546752 15:34:30 INFO - PROCESS | 22599 | 15:37:33 INFO - PROCESS | 22599 | Cycle 1(1): loaded http://localhost:52967/tests/dromaeo/cssquery-ext.html (next: http://localhost:52967/tests/dromaeo/cssquery-jquery.html) 15:37:33 INFO - PROCESS | 22599 | RSS: Main: 270127104 15:37:33 INFO - PROCESS | 22599 | 15:40:36 INFO - PROCESS | 22599 | Cycle 1(1): loaded http://localhost:52967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52967/tests/dromaeo/cssquery-mootools.html) 15:40:36 INFO - PROCESS | 22599 | RSS: Main: 241278976 15:40:36 INFO - PROCESS | 22599 | 15:43:38 INFO - PROCESS | 22599 | Cycle 1(1): loaded http://localhost:52967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52967/tests/dromaeo/cssquery-prototype.html) 15:43:39 INFO - PROCESS | 22599 | RSS: Main: 219561984 15:43:39 INFO - PROCESS | 22599 | 15:46:42 INFO - PROCESS | 22599 | Cycle 1(1): loaded http://localhost:52967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52967/tests/dromaeo/cssquery-yui.html) 15:46:43 INFO - PROCESS | 22599 | RSS: Main: 218390528 15:46:43 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | Cycle 1(1): loaded http://localhost:52967/tests/dromaeo/cssquery-yui.html (next: http://localhost:52967/tests/dromaeo/cssquery-dojo.html) 15:49:46 INFO - PROCESS | 22599 | RSS: Main: 314322944 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | __start_tp_report 15:49:46 INFO - PROCESS | 22599 | _x_x_mozilla_page_load 15:49:46 INFO - PROCESS | 22599 | _x_x_mozilla_page_load_details 15:49:46 INFO - PROCESS | 22599 | |i|pagename|runs| 15:49:46 INFO - PROCESS | 22599 | |0;dojo.html;2558.437143828358;2569.781568566672;2605.921822345329;2623.75074367935;2630.8421494710315;4539.137563862863;4615.423072115986;4717.811287548494;4730.219513780226;4736.7868445919885;4651.581357677808;4684.554967278112;4702.0360826030665;4748.643851711126;4788.114198873202;4336.566343365654;4367.475902891641;4411.80146893389;4428.158649856517;4430.091831174617;4422.6240769534625;4490.595846373826;4495.303227999665;4505.189065968125;4516.164509565724;4252.723572967747;4382.101669157815;4395.318725597537;4402.1195760847795;4507.00845813922;4258.212230737324;4298.398224248608;4341.652667786601;4347.934780978288;4357.825686972517;4310.267254566731;4321.697481176319;4337.63130133939;4379.211741886459;4390.517043125254;4701.224297990828;4732.574068333866;4736.478987311393;4747.95252047482;4789.353437285957;4907.533784290486;4956.306117143603;5058.266551350033;5062.82280120194;5114.565261952738;5157.742112894341;5157.742112894341;5163.044836705221;5203.271541984125;5208.921866172011;4765.833195838129;4771.832985845548;4773.498782627844;4778.211595086772;4851.781669824866;5079.5428411443145;5130.230465430141;5148.819791307361;5243.895122097613;5309.8938021239355;4943.357363542788;4965.32968049316;4967.950320496749;5013.523715247045;5024.221245706921;5055.09008378488;5061.089003979319;5063.493650634907;5067.366579177603;5131.512506311969;4838.056578967138;4872.926906096412;4998.150314446553;5006.89986200274;5009.348784658044;4895.583875370633;4939.2838038484215;4948.233023881304;4950.232713929347;4988.925166122511;4175.791210439465;4182.372644103348;4186.727862688916;4187.43469631602;4234.470691163605;3665.303592317451;3668.2296717689583;3672.265546890633;3672.559292884871;3694.390425579803;4356.085222103394;4407.911841763147;4409.977950110229;4413.073254616503;4415.337699345059;5066.138756411419;5097.388313402341;5101.8724531886255;5113.718745469035;5118.436971933084;4364.279893817548;4397.164538737629;4400.647948164139;4415.205263052617;4460;4523.5250298718165;4532.3654688342995;4534.433195850519;4534.79593418297;4587.931181032287;4751.809927602857;4753.191957367325;4791.904161916742;4810.518948105161;4865.6107511398295;4903.485134060872;4964.67729597575;5074.238864170256;5112.693238405707;5115.74421278942;4807.326974223542;4845.3216549683775;4847.975760121177;4889.462159162418;4896.877578060577;5020.046191223656;5029.446760856376;5031.723255220998;5032.043911656773;5034.521720436553;4782.234842425195;4876.073546026244;5053.29253904461;5071.1632580625255;5073.34046573943;4955.058538877602;4983.327250821093;4989.2516122580455;4991.600671946163;5024.924626130538;4966.553010229097;4968.080905032581;4969.875753106201;4980.028894365564;5021.874453138701;4728.148933192058;4766.571008609242;4772.284157376422;4786.970801277742;4932.506749325039;4948.802047918043;4980.651354405157;4983;5037.546620804145;5038.420581633159;4871.585915197106;4874.4150701916;4893.143699852582;4947.777350019186;4951.207806750903 15:49:46 INFO - PROCESS | 22599 | |1;ext.html;556.1990733343985;560.974756135974;584.3980699879123;585.1895125251525;593.9753924480269;28116.43767124659;38966.415503767465;40107.59892401075;40211.39682904755;43334.13331733371;40400;40932.18135637286;41008;41023;41035.794821025855;7616.466847320689;7748.845023099535;7755.1081625613215;7758;7761.146273909865;7634.809129771745;7649.082110146763;7653.961730191341;7722.189170137139;7730.342920851735;7709.922900770976;7765.339946104559;7772.300492955633;7773.455858089936;7778.183290754474;7662.923370766304;7692.923070769277;7698.2686644768655;7700.11448683403;7708.229177082303;7621.3902887768845;7663.655135518859;7678.769636910902;7681.923180768176;7685.577293248869;37870;38207.66273180453;38217.80891095527;38236.23527529434;38256.234875302616;2982.2246215983782;3057.2356910772305;3075.123589776903;3272.9035773016067;3300.6204286506877;27844.30389240285;27991.580126298122;28172;28225;29694.554581681077;2982.6719060903283;3041.1332770160398;3063.7395821355212;3084.784065115443;3113.8598763055716;244811;245353;246278;246354.7682261595;246997;49391.25913111306;49785.50214497881;49839.75080124576;49847.50152498501;49953;32874.67125328764;33787.32425351528;33824.83087584595;35295.11762205965;35367.4694879577;11194.496247668874;11274.323540587427;11295.830562541403;11308.830367544493;11340.262882912584;10287;10350.482475876175;10357.63748268807;10358.896411035794;10364.792704145875;17659.29362825498;17683.55791105207;17693.38073167433;17741.201645925965;17782;6632.403083722488;6829.112215411965;7010.298970103051;7020.92979070213;7023.262557431498;776.4991580430591;863.8574635185249;871.0897112517434;873.3362644390309;910.0444533240071;26372.736272637027;27440.313992150357;27486.18094219465;27746.583801242996;28239.57640635392;779.3842864137381;901.2834796336928;911.2618778789202;992.6178421307849;1009.5860697114148;13865.306734663227;14891.106533608017;14993.175375354242;15258.237088145548;15276.923615381851;371275;371633;371681;372045;372969;48158.518414816106;48562.5143748565;48599.514004860204;48692.75653621709;48757;1067.2049323254225;1079.4494807648157;1080.8324709670014;1149.3391300002531;1160.4023927677254;25907;28516;30645.54031689571;31392.215194620316;31928.201794955312;45265.32102018538;45747;45904.31143532783;46053.76973115113;46088;264002;264795;265634;265766;266204;22020;22605;22704.88647556818;22729.659055114516;24493.142740004016;41483.58516414918;41545.79227103845;41604.58395416128;42282.36576451294;42701.57298426976;35044.47433288554;35683.46474802828;35905.82047089748;36017;36827;35772.64227357797;35833.28333433369;35854.64145358513;35979.28041439209;36300.81849590735;35044.69195544827;35401.114972125906;35532.467012995345;35617.64382356143;35674.28651426905;30552.388952221274;32310;32362.35275294528;32527.34945301128;32914.83542582272;24368;25042.62436063497;25048;25286.747132529174;25338.619920700836 15:49:46 INFO - PROCESS | 22599 | |2;jquery.html;344.2770182616504;364.4369449200986;370.57013863917854;376.43346763121497;384.84606157536984;12133.696657583565;12267.429374670544;13582.3208839558;14433.494827681034;16865.07242101684;15853.20733963303;16034.518964431056;16167.83832161678;16171.595710107253;16256.51230463085;4869.440014398354;4916.360873086503;5056.494350564951;5061.6962982221185;5127.512886275797;3568.3933731265747;3789.905252368699;4967.00659868026;5052.520010598987;5059.064073146461;3808.086059345751;3812.504374431334;3814.1608846053823;5548.805791797288;5901.586888917777;4989.426215985171;5242.659227150261;5918.1418694289305;5952.077427998667;5954.821355359346;5066.620003499752;5074.873128171826;5075.720835354054;5076.060928728197;5080.466551012164;11272.15458840582;11301.378424186667;11521.827172592419;11638.185327027111;11742.823857642057;1812.664657038452;1845.1143451143391;1854.9629007419776;1904.1050706168078;2045.7238272833274;8627.482351058956;8861.379703420764;9199.218066464358;10507.632232871812;13026.218426894417;1697.1429428138833;1742.9564260893453;1762.118940529735;1768.4694591622463;1792.4622613215984;64403;65612.67193664049;65674;65793.67103164502;66338;9452.90547094534;9488.525573721286;9653.324267301221;9711.417314961125;9766.46284454362;13133.540326088541;13137.978264999103;13164.539241126706;13165.407556659973;13169;6772.52592318533;6925.307469253135;6929.930700693029;7082.362587367059;7149.642517874086;6533.705983230766;6595.703193356215;6718.66406679664;6770.356816102462;6842.247352791289;4025.5571887092397;4063.898402539901;4090.202410529918;4094.9181016379507;4192.4759405074365;1767.6729804986119;1806.4915795310799;1820.4447643468604;1839.0988415676222;1865.822746839048;808.6967387229789;813.979650508742;861.8965724113147;905.3345790843724;917.0508523677961;15692.529224123295;15835.366585336458;15905.920470397805;16247.918760406123;16432.75350869738;821.8865717217492;862.8533149364623;870.9042005379404;871.3595507302127;914.2868562521244;8846.292296616255;8927.075437826687;9291.62833486653;9302.674406395743;9313.44119352841;359817;361325.3968253968;366441.6711665805;366737;368138;68452.657736711;73335;74700;75054;77212;839.8278352937633;861.0958493581714;863.2834747159842;864.2394692670409;868.1188593577524;14171.362288696828;14216.715665686836;14311;14334.354954027302;14953.700925981637;24494.265172044867;35115.64884351124;35610;36046.459303111;36285.45571816372;46191.76904115458;46255;46493.53506464892;46887.531124688314;49898.25152622786;7342.9632851835395;7388.926110739038;7418.777436676908;7419.406447484296;7465.514741541782;10622.628208012991;10997.285176463503;11063.557457701601;11288.830667540158;11337.829932550854;8195.46729462583;8781.29749620016;8898.73303800887;9063.456192628464;10175.643852465424;8840.071792461698;9229.953850230706;9598.280128990215;9646.062927659412;9913.355631883904;9224.262059035127;9293.907060929305;9359.672411465566;9438.622455101993;9694.369865958972;7067.646617668993;7105.467089968376;7179.246179151114;7181.856362872609;7233.529820561646;7611.391088712779;9268.95365523168;9276.610950093474;9508.572114255014;9550.665726699532 15:49:46 INFO - PROCESS | 22599 | |3;mootools.html;1214.059104194249;1284.6916739982405;1361.3873756809435;1363.51376999071;1678.4041665208852;6811.352921472459;7627.3898088152955;7897.526148431091;7905;8120.228578285069;7893.526388416699;7954.880676789853;7962.800929976739;7965.203479652032;7968.721094761684;2141.3468891987936;2161.632522471176;2173.6413491773837;2177.3032629558547;2185.573813106445;2084.0725876984748;2125.203048856679;2158.8272938164987;2160.2979031814725;2165.2096984600585;2151.505153814616;2155.5365596396773;2171.1315473810446;2177.1835561664375;2202.4053505553493;2128.8190503807195;2130.414136112581;2137.7434707835005;2139.4116617930194;2139.8609090409072;2047.9897600511902;2085.780992995744;2091.288961752996;2092.1735914313763;2112.41908475169;7736.883946740803;7870.527768333918;7904.841903161962;7957.124716281204;7966.760997170094;4322.113966636832;4510.075434535912;4520.773961301955;4522.050369422425;4524.660650451229;2567.127176759892;2665.8533780642056;2690.4753573053263;2699.20373489821;2707.187843646918;744.0847757258603;745.8955746195537;756.916739158692;759.8176437654978;759.9126100498459;10798.136149108053;10908.836367454414;10942.781144377148;10952.99999999992;10978.835317470244;3874.535055793323;3980.283548961157;4107.445494858156;4127.33962565988;4132.710710250314;8258.298044666151;8261.421700480909;8269.173082691683;8269.21442462965;8286.295664868554;4332.935005974913;4342.196693611692;4344.847930322424;4344.869653910388;4346.6308112944325;3534.8939531814085;3630.7821530708243;3876.7867767272505;3988.4017397390626;3991.980040099781;3352.078178500883;3388.3053973935284;3498.2303893143467;3500.982495087559;3504.684578387906;953.9379940303858;976.038601977052;976.4043933200742;978.2516374973151;980.9313348065709;797.4218691448654;800.203797221768;801.418971245842;805.814662627599;823.6087858267275;4829.589484893753;4936.605071594264;4954.430240522314;5060.671056381323;5172.844814655491;345.9429194182982;347.298457116623;348.0550305919441;348.621745406232;351.13795631724054;3223.323102148528;3406.0803583032443;3431.9142021449165;3453.2748122893972;3477.078574177845;9211;9552.235821134293;9584.424934503952;9817.410955342702;9859.901400986042;9736.123748862636;9738.951305243429;9740.318177727633;9759.365641233297;9765.121139097515;6954.478414118961;7156.856862862818;7158.176809666851;7160.140783105957;7160.248173941765;4980.950190498049;4988.900221995613;5075.137226671401;5104.2343648453025;5128.769205385692;8499.10759370282;8624;8629.827403452022;8695.782605434915;8733.519656418957;8650.697225597074;8712.128787121237;8877.28981681451;8881;8908.331875109523;5866.941330586639;6647.634380109141;6776.6950487227205;6778.389944904982;6780.830479238059;6646.202455705346;7362.447816413897;7452.105747310357;7643.541387516767;7647.158812530728;6420.582662126947;6580.177477815273;6640.468762499085;6643.867122657616;6697.3302669734585;6618.271990080991;6664.66676666155;6718.93281067183;6791.286914874065;6840.41856442208;6001.549883758823;6067.089936509559;6073.544484163617;6075.908861367171;6080.2399700037495;4412.536683648171;4581.63346932238;4619.376384188226;4626.1904166771355;4644.465886423104;4477.977610111929;4563.429571303587;4673.836415725434;4676.7661616919695;4802.039592081528 15:49:46 INFO - PROCESS | 22599 | |4;prototype.html;297.51950599781355;301.3520930000499;304.5523081070826;307.6846232611574;307.89069880192517;4765.666403351766;4775.904481910364;4792.472827988919;4831.444383895853;4843.636727245462;4775.5912005958235;4782.928256076161;4789.760511974405;4796.057596673353;4812.205986012304;3578.5884623268266;3681.521402217708;3686.668199862012;3769.453429252757;3795.5065841440573;3799.639034291738;3803.1633040730994;3814.5994670559608;3819.3888977763563;3832.6742226910746;3742.513473248474;3781.73527853049;3785.6782173515285;3805.6194380562;3812.3519001769764;3576.356255873942;3621.2938476996997;3694.704423646102;3738.420544815558;3755.286495565834;3312.850921708529;3316.303576248991;3318.7179089777396;3320.96679033209;3334.3998080345527;4647.070585882837;4647.23320652092;4651.465081515636;4651.976740116278;4663.183942809995;4202.201581699467;4278.2940814765525;4294.398784170218;4317.633001194902;4327.0913108247305;4962.429320628102;4979.7261150636705;4983.875403114951;5000.549950504472;5003;3637.217998130415;3652.6347365263528;3659.1949771050326;3662.7252956028137;3673.8163091845568;5148.742562871879;5156.051412152781;5227.973860130675;5263.789448422059;5279.366476022863;3713.628637136265;3763.096856754359;3786.5645450773513;3805.5813860475328;3808.27642747877;3845.634934515253;3858.6913046956174;3860.4595356650093;3861.4400911868183;3863.4204869269274;4346.869593912124;4359.738415695068;4365.454318210223;4375.365571992043;4378.890527736832;4948.480409557017;4986.501349865057;5037.858909963251;5065;5102.540771330524;1295.4429595274123;1314.4479318686174;1318.6044186743939;1319.3732976835927;1324.8343957005375;821.6097353756918;852.5268475995758;856.4818284937647;871.3464901324007;871.9389642724948;4237.851675191354;4336.392904993303;4408.977955110268;4484.260097083945;4506.954930450719;5144.356955380577;5155.53600175986;5166;5188.844334669966;5192.402873669576;4494.887627809331;4496.235639941217;4503.626393949877;4509.819607215674;4520.118576877543;2595.766381025717;2729.235813972091;2734.5214587447517;2740;2743.3278846682692;4895;4895.192293271571;4901.828436004723;4909.189983652729;4948.480409556944;5051.191809310492;5288.7355632219005;5292.655977361459;5292.947070529245;5319.867003324948;4902.28916807061;4908.828191013297;4928.260760885824;4928.901421971541;4954.380702412199;5060.165072762953;5120.231965205249;5137.460566640599;5163.845084647466;5185.299984502044;4855.67386340358;5066.847994560169;5100.934121680725;5110.390227078458;5116.616253780907;4933.284673722362;4949.802007919643;4962.404511458648;4963.429205641398;4970.403551573834;3623.7463377563317;3639.363111455538;3646.762960407565;3671.1556342040944;3682.4660424238873;5105.566026887756;5294.073537131064;5301.125314323093;5308.548773354154;5308.814191503433;5020.47285035066;5021.44764075944;5059.291699162047;5070.898582028412;5087.720175390389;5038.596912246938;5054.494550544916;5055.418626857959;5096.490350964874;5096.872578185575;4682.648801339981;4976.452590215146;4984.651074424755;4994.775235114501;5009.298698182331;4879.414470263449;5002.349694539686;5003.724795136302;5072.213806859942;5102.36220472441;4951.5791157750555;4979.153543897473;4988.152014157529;4989.675671081368;4993.850184494471 15:49:46 INFO - PROCESS | 22599 | |5;yui.html;591.7839988404232;591.7987884119399;646.5861848417014;647.5920170292715;672.4754691340756;11427.42862856857;11755.294682319056;11863.228890122136;11996.880031199686;12112.818307725369;10973.341599504016;11780.293182409061;11832.29006259625;11871.109666775004;11892.167548271624;614.0758158970742;741.2920660768966;761.8362052158785;762.9351505122071;765.0551568812513;619.1734035063173;740.9296116868888;758.4122305213476;763.0881097088981;771.0554570650936;811.2050190812977;814.2712272516095;814.9266566009057;814.9511029338229;815.339574944297;642.8714257148589;805.3919290935365;806.0247101007758;806.310604433207;806.6773290683715;485.8032496838786;561.1862798941511;571.1119209629026;572.0732413490173;579.8086631411624;11117.610883619034;11574.363410012445;11580.536778528849;11580.826287605692;11589.536418543248;10829.83755243672;11063.557457701681;11071.72320691981;11541.884581154165;11703.23928944616;10085;10086.49567521621;10226.586931475353;10288.382697038202;10422.9478852606;4042.535108462535;4053.7567745935044;4054.2499637567144;4055.5336136344404;4118.711690181688;59123.704381477815;59909.7004514979;60490.39509604892;60843.39156608466;61700.69149654268;9726.416415015121;9747.658831940847;9818.067283608189;9902.55438505269;9973.351732137387;16154.596135096717;17000.82999170017;17954.820451795575;17959.461216163538;17981.910090449463;6674.365935236145;6696.19645642526;6817.386435220854;6870.27862074485;6941.757038503729;3463.930721385558;3475.878344257939;3499.3701133795653;3539.911502212414;3658.0854786303425;2900.318425170083;3012.834294113845;3018.5321275202377;3025.6066711327385;3026.031669865622;493.6396430605606;499.5903359245384;501.1830715933006;501.44840675256927;512.9410117836496;452.3215177234149;517.3248910172262;518.9558887494605;539.8893226888479;543.2204786131913;7523.322900938832;7533.924660753432;7611.961940190264;7931.524108553505;8169.959150204211;474.26488942140236;493.44980346912934;501.6939666803247;506.71370675568187;509.1573445946964;3401.880934167342;3452.430348992438;3695.0577602711674;3716.3394056853977;3774.7735135891935;54402.72798636061;98124;99185.50407247918;100171;102781.48609256906;84454.57772711097;85011;86683;87625.56187219151;87810.56094719486;76977.6151119252;78559.60720196362;78953.60523197347;79168.60415697885;79670.82139661019;6776.93223067763;7040.852188633985;7107.111611048619;7281.2718728126765;7388.778336649909;43445.74530839257;43608;43861;45383;45759;60450;63538.364616355095;63846.68076659587;64339.67830160819;66270.8170895076;9644.903550964682;9752.122308992224;9915.314570772893;10085.747856303651;10259.58961641526;9477.194438472807;9669.516524173903;9903.900960990299;9935.20518358515;10107.241956853413;8495.362847786564;10012.148967337858;10045.799084018425;10284.845727313947;10659.147268218368;8955.955220223857;9772.560234789593;9963.153131983863;9966.651167209113;10004.899951000396;10082.143017843273;10461.05850473461;10506.842397364198;10538.631147909786;10592;8564.314854811475;8609.455150422787;8683.782905427415;8960.731178064669;9238.399504032217;9077.137671921157;9244.567092100735;9248.260139188984;9301.813963720822;9429.81140377175 15:49:46 INFO - PROCESS | 22599 | __end_tp_report 15:49:46 INFO - PROCESS | 22599 | __start_cc_report 15:49:46 INFO - PROCESS | 22599 | _x_x_mozilla_cycle_collect,1267 15:49:46 INFO - PROCESS | 22599 | __end_cc_report 15:49:46 INFO - PROCESS | 22599 | __startTimestamp1475362186399__endTimestamp 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | ------- Summary: start ------- 15:49:46 INFO - PROCESS | 22599 | Number of tests: 6 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | [#0] dojo.html Cycles:165 Average:4680.42 Median:4807.33 stddev:500.16 (10.4%) stddev-sans-first:473.18 15:49:46 INFO - PROCESS | 22599 | Values: 2558.4 2569.8 2605.9 2623.8 2630.8 4539.1 4615.4 4717.8 4730.2 4736.8 4651.6 4684.6 4702.0 4748.6 4788.1 4336.6 4367.5 4411.8 4428.2 4430.1 4422.6 4490.6 4495.3 4505.2 4516.2 4252.7 4382.1 4395.3 4402.1 4507.0 4258.2 4298.4 4341.7 4347.9 4357.8 4310.3 4321.7 4337.6 4379.2 4390.5 4701.2 4732.6 4736.5 4748.0 4789.4 4907.5 4956.3 5058.3 5062.8 5114.6 5157.7 5157.7 5163.0 5203.3 5208.9 4765.8 4771.8 4773.5 4778.2 4851.8 5079.5 5130.2 5148.8 5243.9 5309.9 4943.4 4965.3 4968.0 5013.5 5024.2 5055.1 5061.1 5063.5 5067.4 5131.5 4838.1 4872.9 4998.2 5006.9 5009.3 4895.6 4939.3 4948.2 4950.2 4988.9 4175.8 4182.4 4186.7 4187.4 4234.5 3665.3 3668.2 3672.3 3672.6 3694.4 4356.1 4407.9 4410.0 4413.1 4415.3 5066.1 5097.4 5101.9 5113.7 5118.4 4364.3 4397.2 4400.6 4415.2 4460.0 4523.5 4532.4 4534.4 4534.8 4587.9 4751.8 4753.2 4791.9 4810.5 4865.6 4903.5 4964.7 5074.2 5112.7 5115.7 4807.3 4845.3 4848.0 4889.5 4896.9 5020.0 5029.4 5031.7 5032.0 5034.5 4782.2 4876.1 5053.3 5071.2 5073.3 4955.1 4983.3 4989.3 4991.6 5024.9 4966.6 4968.1 4969.9 4980.0 5021.9 4728.1 4766.6 4772.3 4787.0 4932.5 4948.8 4980.7 4983.0 5037.5 5038.4 4871.6 4874.4 4893.1 4947.8 4951.2 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | [#1] ext.html Cycles:180 Average:44521.80 Median:35843.96 stddev:78732.05 (219.7%) stddev-sans-first:78883.72 15:49:46 INFO - PROCESS | 22599 | Values: 556.2 561.0 584.4 585.2 594.0 28116.4 38966.4 40107.6 40211.4 43334.1 40400.0 40932.2 41008.0 41023.0 41035.8 7616.5 7748.8 7755.1 7758.0 7761.1 7634.8 7649.1 7654.0 7722.2 7730.3 7709.9 7765.3 7772.3 7773.5 7778.2 7662.9 7692.9 7698.3 7700.1 7708.2 7621.4 7663.7 7678.8 7681.9 7685.6 37870.0 38207.7 38217.8 38236.2 38256.2 2982.2 3057.2 3075.1 3272.9 3300.6 27844.3 27991.6 28172.0 28225.0 29694.6 2982.7 3041.1 3063.7 3084.8 3113.9 244811.0 245353.0 246278.0 246354.8 246997.0 49391.3 49785.5 49839.8 49847.5 49953.0 32874.7 33787.3 33824.8 35295.1 35367.5 11194.5 11274.3 11295.8 11308.8 11340.3 10287.0 10350.5 10357.6 10358.9 10364.8 17659.3 17683.6 17693.4 17741.2 17782.0 6632.4 6829.1 7010.3 7020.9 7023.3 776.5 863.9 871.1 873.3 910.0 26372.7 27440.3 27486.2 27746.6 28239.6 779.4 901.3 911.3 992.6 1009.6 13865.3 14891.1 14993.2 15258.2 15276.9 371275.0 371633.0 371681.0 372045.0 372969.0 48158.5 48562.5 48599.5 48692.8 48757.0 1067.2 1079.4 1080.8 1149.3 1160.4 25907.0 28516.0 30645.5 31392.2 31928.2 45265.3 45747.0 45904.3 46053.8 46088.0 264002.0 264795.0 265634.0 265766.0 266204.0 22020.0 22605.0 22704.9 22729.7 24493.1 41483.6 41545.8 41604.6 42282.4 42701.6 35044.5 35683.5 35905.8 36017.0 36827.0 35772.6 35833.3 35854.6 35979.3 36300.8 35044.7 35401.1 35532.5 35617.6 35674.3 30552.4 32310.0 32362.4 32527.3 32914.8 24368.0 25042.6 25048.0 25286.7 25338.6 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | [#2] jquery.html Cycles:180 Average:22548.71 Median:5064.16 stddev:60259.40 (1189.9%) stddev-sans-first:60405.38 15:49:46 INFO - PROCESS | 22599 | Values: 344.3 364.4 370.6 376.4 384.8 12133.7 12267.4 13582.3 14433.5 16865.1 15853.2 16034.5 16167.8 16171.6 16256.5 4869.4 4916.4 5056.5 5061.7 5127.5 3568.4 3789.9 4967.0 5052.5 5059.1 3808.1 3812.5 3814.2 5548.8 5901.6 4989.4 5242.7 5918.1 5952.1 5954.8 5066.6 5074.9 5075.7 5076.1 5080.5 11272.2 11301.4 11521.8 11638.2 11742.8 1812.7 1845.1 1855.0 1904.1 2045.7 8627.5 8861.4 9199.2 10507.6 13026.2 1697.1 1743.0 1762.1 1768.5 1792.5 64403.0 65612.7 65674.0 65793.7 66338.0 9452.9 9488.5 9653.3 9711.4 9766.5 13133.5 13138.0 13164.5 13165.4 13169.0 6772.5 6925.3 6929.9 7082.4 7149.6 6533.7 6595.7 6718.7 6770.4 6842.2 4025.6 4063.9 4090.2 4094.9 4192.5 1767.7 1806.5 1820.4 1839.1 1865.8 808.7 814.0 861.9 905.3 917.1 15692.5 15835.4 15905.9 16247.9 16432.8 821.9 862.9 870.9 871.4 914.3 8846.3 8927.1 9291.6 9302.7 9313.4 359817.0 361325.4 366441.7 366737.0 368138.0 68452.7 73335.0 74700.0 75054.0 77212.0 839.8 861.1 863.3 864.2 868.1 14171.4 14216.7 14311.0 14334.4 14953.7 24494.3 35115.6 35610.0 36046.5 36285.5 46191.8 46255.0 46493.5 46887.5 49898.3 7343.0 7388.9 7418.8 7419.4 7465.5 10622.6 10997.3 11063.6 11288.8 11337.8 8195.5 8781.3 8898.7 9063.5 10175.6 8840.1 9230.0 9598.3 9646.1 9913.4 9224.3 9293.9 9359.7 9438.6 9694.4 7067.6 7105.5 7179.2 7181.9 7233.5 7611.4 9269.0 9276.6 9508.6 9550.7 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | [#3] mootools.html Cycles:180 Average:5008.80 Median:5067.90 stddev:2906.46 (57.4%) stddev-sans-first:2900.62 15:49:46 INFO - PROCESS | 22599 | Values: 1214.1 1284.7 1361.4 1363.5 1678.4 6811.4 7627.4 7897.5 7905.0 8120.2 7893.5 7954.9 7962.8 7965.2 7968.7 2141.3 2161.6 2173.6 2177.3 2185.6 2084.1 2125.2 2158.8 2160.3 2165.2 2151.5 2155.5 2171.1 2177.2 2202.4 2128.8 2130.4 2137.7 2139.4 2139.9 2048.0 2085.8 2091.3 2092.2 2112.4 7736.9 7870.5 7904.8 7957.1 7966.8 4322.1 4510.1 4520.8 4522.1 4524.7 2567.1 2665.9 2690.5 2699.2 2707.2 744.1 745.9 756.9 759.8 759.9 10798.1 10908.8 10942.8 10953.0 10978.8 3874.5 3980.3 4107.4 4127.3 4132.7 8258.3 8261.4 8269.2 8269.2 8286.3 4332.9 4342.2 4344.8 4344.9 4346.6 3534.9 3630.8 3876.8 3988.4 3992.0 3352.1 3388.3 3498.2 3501.0 3504.7 953.9 976.0 976.4 978.3 980.9 797.4 800.2 801.4 805.8 823.6 4829.6 4936.6 4954.4 5060.7 5172.8 345.9 347.3 348.1 348.6 351.1 3223.3 3406.1 3431.9 3453.3 3477.1 9211.0 9552.2 9584.4 9817.4 9859.9 9736.1 9739.0 9740.3 9759.4 9765.1 6954.5 7156.9 7158.2 7160.1 7160.2 4981.0 4988.9 5075.1 5104.2 5128.8 8499.1 8624.0 8629.8 8695.8 8733.5 8650.7 8712.1 8877.3 8881.0 8908.3 5866.9 6647.6 6776.7 6778.4 6780.8 6646.2 7362.4 7452.1 7643.5 7647.2 6420.6 6580.2 6640.5 6643.9 6697.3 6618.3 6664.7 6718.9 6791.3 6840.4 6001.5 6067.1 6073.5 6075.9 6080.2 4412.5 4581.6 4619.4 4626.2 4644.5 4478.0 4563.4 4673.8 4676.8 4802.0 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | [#4] prototype.html Cycles:180 Average:4198.51 Median:4791.12 stddev:1211.88 (25.3%) stddev-sans-first:1179.38 15:49:46 INFO - PROCESS | 22599 | Values: 297.5 301.4 304.6 307.7 307.9 4765.7 4775.9 4792.5 4831.4 4843.6 4775.6 4782.9 4789.8 4796.1 4812.2 3578.6 3681.5 3686.7 3769.5 3795.5 3799.6 3803.2 3814.6 3819.4 3832.7 3742.5 3781.7 3785.7 3805.6 3812.4 3576.4 3621.3 3694.7 3738.4 3755.3 3312.9 3316.3 3318.7 3321.0 3334.4 4647.1 4647.2 4651.5 4652.0 4663.2 4202.2 4278.3 4294.4 4317.6 4327.1 4962.4 4979.7 4983.9 5000.5 5003.0 3637.2 3652.6 3659.2 3662.7 3673.8 5148.7 5156.1 5228.0 5263.8 5279.4 3713.6 3763.1 3786.6 3805.6 3808.3 3845.6 3858.7 3860.5 3861.4 3863.4 4346.9 4359.7 4365.5 4375.4 4378.9 4948.5 4986.5 5037.9 5065.0 5102.5 1295.4 1314.4 1318.6 1319.4 1324.8 821.6 852.5 856.5 871.3 871.9 4237.9 4336.4 4409.0 4484.3 4507.0 5144.4 5155.5 5166.0 5188.8 5192.4 4494.9 4496.2 4503.6 4509.8 4520.1 2595.8 2729.2 2734.5 2740.0 2743.3 4895.0 4895.2 4901.8 4909.2 4948.5 5051.2 5288.7 5292.7 5292.9 5319.9 4902.3 4908.8 4928.3 4928.9 4954.4 5060.2 5120.2 5137.5 5163.8 5185.3 4855.7 5066.8 5100.9 5110.4 5116.6 4933.3 4949.8 4962.4 4963.4 4970.4 3623.7 3639.4 3646.8 3671.2 3682.5 5105.6 5294.1 5301.1 5308.5 5308.8 5020.5 5021.4 5059.3 5070.9 5087.7 5038.6 5054.5 5055.4 5096.5 5096.9 4682.6 4976.5 4984.7 4994.8 5009.3 4879.4 5002.3 5003.7 5072.2 5102.4 4951.6 4979.2 4988.2 4989.7 4993.9 15:49:46 INFO - PROCESS | 22599 | 15:49:46 INFO - PROCESS | 22599 | [#5] yui.html Cycles:180 Average:17156.45 Median:585.80 stddev:25482.18 (4350.0%) stddev-sans-first:25523.31 15:49:46 INFO - PROCESS | 22599 | Values: 591.8 591.8 646.6 647.6 672.5 11427.4 11755.3 11863.2 11996.9 12112.8 10973.3 11780.3 11832.3 11871.1 11892.2 614.1 741.3 761.8 762.9 765.1 619.2 740.9 758.4 763.1 771.1 811.2 814.3 814.9 815.0 815.3 642.9 805.4 806.0 806.3 806.7 485.8 561.2 571.1 572.1 579.8 11117.6 11574.4 11580.5 11580.8 11589.5 10829.8 11063.6 11071.7 11541.9 11703.2 10085.0 10086.5 10226.6 10288.4 10422.9 4042.5 4053.8 4054.2 4055.5 4118.7 59123.7 59909.7 60490.4 60843.4 61700.7 9726.4 9747.7 9818.1 9902.6 9973.4 16154.6 17000.8 17954.8 17959.5 17981.9 6674.4 6696.2 6817.4 6870.3 6941.8 3463.9 3475.9 3499.4 3539.9 3658.1 2900.3 3012.8 3018.5 3025.6 3026.0 493.6 499.6 501.2 501.4 512.9 452.3 517.3 519.0 539.9 543.2 7523.3 7533.9 7612.0 7931.5 8170.0 474.3 493.4 501.7 506.7 509.2 3401.9 3452.4 3695.1 3716.3 3774.8 54402.7 98124.0 99185.5 100171.0 102781.5 84454.6 85011.0 86683.0 87625.6 87810.6 76977.6 78559.6 78953.6 79168.6 79670.8 6776.9 7040.9 7107.1 7281.3 7388.8 43445.7 43608.0 43861.0 45383.0 45759.0 60450.0 63538.4 63846.7 64339.7 66270.8 9644.9 9752.1 9915.3 10085.7 10259.6 9477.2 9669.5 9903.9 9935.2 10107.2 8495.4 10012.1 10045.8 10284.8 10659.1 8956.0 9772.6 9963.2 9966.7 10004.9 10082.1 10461.1 10506.8 10538.6 10592.0 8564.3 8609.5 8683.8 8960.7 9238.4 9077.1 9244.6 9248.3 9301.8 9429.8 15:49:46 INFO - PROCESS | 22599 | -------- Summary: end -------- 15:49:46 INFO - PROCESS | 22599 | 15:49:47 INFO - TEST-INFO | 22599: exit 0 15:49:47 INFO - TEST-OK | dromaeo_css | took 1122586ms 15:49:47 INFO - TEST-START | kraken 15:49:47 INFO - operating with platform_type : linux_ 15:49:47 INFO - Initialising browser for kraken test... 15:49:47 INFO - TEST-INFO | started process 22901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKc2hB1/profile http://localhost:52967/getInfo.html) 15:49:52 INFO - PROCESS | 22901 | __metrics Screen width/height:1600/1200 15:49:52 INFO - PROCESS | 22901 | colorDepth:24 15:49:52 INFO - PROCESS | 22901 | Browser inner width/height: 1024/697 15:49:52 INFO - PROCESS | 22901 | __metrics 15:49:52 INFO - PROCESS | 22901 | 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" 15:49:52 INFO - PROCESS | 22901 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:49:53 INFO - PROCESS | 22901 | console.error: PushService: 15:49:53 INFO - PROCESS | 22901 | stateChangeProcessEnqueue: Error transitioning state 15:49:53 INFO - PROCESS | 22901 | UnknownError 15:49:53 INFO - TEST-INFO | 22901: exit 0 15:49:53 INFO - Browser initialized. 15:49:53 INFO - Running cycle 1/1 for kraken test... 15:49:53 INFO - TEST-INFO | started process 22980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKc2hB1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:06 INFO - PROCESS | 22980 | RSS: Main: 175017984 15:50:06 INFO - PROCESS | 22980 | 15:50:08 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52967/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:09 INFO - PROCESS | 22980 | RSS: Main: 237715456 15:50:09 INFO - PROCESS | 22980 | 15:50:12 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52967/tests/kraken/driver.html?testName=audio-dft) 15:50:13 INFO - PROCESS | 22980 | RSS: Main: 218411008 15:50:13 INFO - PROCESS | 22980 | 15:50:16 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52967/tests/kraken/driver.html?testName=audio-fft) 15:50:17 INFO - PROCESS | 22980 | RSS: Main: 300032000 15:50:17 INFO - PROCESS | 22980 | 15:50:19 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52967/tests/kraken/driver.html?testName=audio-oscillator) 15:50:19 INFO - PROCESS | 22980 | RSS: Main: 210386944 15:50:19 INFO - PROCESS | 22980 | 15:50:22 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:22 INFO - PROCESS | 22980 | RSS: Main: 213458944 15:50:22 INFO - PROCESS | 22980 | 15:50:26 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52967/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:26 INFO - PROCESS | 22980 | RSS: Main: 250429440 15:50:26 INFO - PROCESS | 22980 | 15:50:30 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52967/tests/kraken/driver.html?testName=imaging-desaturate) 15:50:30 INFO - PROCESS | 22980 | RSS: Main: 244314112 15:50:30 INFO - PROCESS | 22980 | 15:50:33 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52967/tests/kraken/driver.html?testName=json-parse-financial) 15:50:34 INFO - PROCESS | 22980 | RSS: Main: 247902208 15:50:34 INFO - PROCESS | 22980 | 15:50:35 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:50:36 INFO - PROCESS | 22980 | RSS: Main: 211337216 15:50:36 INFO - PROCESS | 22980 | 15:50:38 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:50:39 INFO - PROCESS | 22980 | RSS: Main: 218222592 15:50:39 INFO - PROCESS | 22980 | 15:50:41 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:50:41 INFO - PROCESS | 22980 | RSS: Main: 222801920 15:50:41 INFO - PROCESS | 22980 | 15:50:44 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:50:45 INFO - PROCESS | 22980 | RSS: Main: 223395840 15:50:45 INFO - PROCESS | 22980 | 15:50:48 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:50:49 INFO - PROCESS | 22980 | RSS: Main: 222015488 15:50:49 INFO - PROCESS | 22980 | 15:50:50 INFO - PROCESS | 22980 | Cycle 1(1): loaded http://localhost:52967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52967/tests/kraken/driver.html?testName=ai-astar) 15:50:51 INFO - PROCESS | 22980 | RSS: Main: 273039360 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | __start_tp_report 15:50:51 INFO - PROCESS | 22980 | _x_x_mozilla_page_load 15:50:51 INFO - PROCESS | 22980 | _x_x_mozilla_page_load_details 15:50:51 INFO - PROCESS | 22980 | |i|pagename|runs| 15:50:51 INFO - PROCESS | 22980 | |0;ai-astar;111;113;113;112;112;113;114;113;113;112 15:50:51 INFO - PROCESS | 22980 | |1;audio-beat-detection;156;135;127;169;132;130;134;135;162;129 15:50:51 INFO - PROCESS | 22980 | |2;audio-dft;160;161;162;162;162;161;161;161;164;160 15:50:51 INFO - PROCESS | 22980 | |3;audio-fft;75;76;75;101;76;76;76;77;106;76 15:50:51 INFO - PROCESS | 22980 | |4;audio-oscillator;84;83;114;82;83;84;119;83;83;109 15:50:51 INFO - PROCESS | 22980 | |5;imaging-gaussian-blur;118;117;117;116;116;117;116;117;116;117 15:50:51 INFO - PROCESS | 22980 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;149 15:50:51 INFO - PROCESS | 22980 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 15:50:51 INFO - PROCESS | 22980 | |8;json-parse-financial;64;67;63;63;65;65;64;65;65;66 15:50:51 INFO - PROCESS | 22980 | |9;json-stringify-tinderbox;66;67;66;66;67;67;66;68;66;70 15:50:51 INFO - PROCESS | 22980 | |10;stanford-crypto-aes;91;83;83;83;90;82;83;83;84;82 15:50:51 INFO - PROCESS | 22980 | |11;stanford-crypto-ccm;160;141;142;148;148;154;140;137;176;144 15:50:51 INFO - PROCESS | 22980 | |12;stanford-crypto-pbkdf2;181;181;183;179;180;177;184;176;177;176 15:50:51 INFO - PROCESS | 22980 | |13;stanford-crypto-sha256-iterative;71;72;71;74;75;73;83;70;69;70 15:50:51 INFO - PROCESS | 22980 | __end_tp_report 15:50:51 INFO - PROCESS | 22980 | __start_cc_report 15:50:51 INFO - PROCESS | 22980 | _x_x_mozilla_cycle_collect,1928 15:50:51 INFO - PROCESS | 22980 | __end_cc_report 15:50:51 INFO - PROCESS | 22980 | __startTimestamp1475362251166__endTimestamp 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | ------- Summary: start ------- 15:50:51 INFO - PROCESS | 22980 | Number of tests: 14 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.84 (0.7%) stddev-sans-first:0.67 15:50:51 INFO - PROCESS | 22980 | Values: 111.0 113.0 113.0 112.0 112.0 113.0 114.0 113.0 113.0 112.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:135.00 stddev:15.32 (11.3%) stddev-sans-first:15.25 15:50:51 INFO - PROCESS | 22980 | Values: 156.0 135.0 127.0 169.0 132.0 130.0 134.0 135.0 162.0 129.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.13 15:50:51 INFO - PROCESS | 22980 | Values: 160.0 161.0 162.0 162.0 162.0 161.0 161.0 161.0 164.0 160.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:11.72 (15.4%) stddev-sans-first:12.20 15:50:51 INFO - PROCESS | 22980 | Values: 75.0 76.0 75.0 101.0 76.0 76.0 76.0 77.0 106.0 76.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.00 stddev:15.10 (18.2%) stddev-sans-first:15.71 15:50:51 INFO - PROCESS | 22980 | Values: 84.0 83.0 114.0 82.0 83.0 84.0 119.0 83.0 83.0 109.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 15:50:51 INFO - PROCESS | 22980 | Values: 118.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:50:51 INFO - PROCESS | 22980 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 149.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:50:51 INFO - PROCESS | 22980 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 15:50:51 INFO - PROCESS | 22980 | Values: 64.0 67.0 63.0 63.0 65.0 65.0 64.0 65.0 65.0 66.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:1.32 15:50:51 INFO - PROCESS | 22980 | Values: 66.0 67.0 66.0 66.0 67.0 67.0 66.0 68.0 66.0 70.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.00 stddev:3.27 (3.9%) stddev-sans-first:2.45 15:50:51 INFO - PROCESS | 22980 | Values: 91.0 83.0 83.0 83.0 90.0 82.0 83.0 83.0 84.0 82.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:148.00 stddev:11.74 (7.9%) stddev-sans-first:11.76 15:50:51 INFO - PROCESS | 22980 | Values: 160.0 141.0 142.0 148.0 148.0 154.0 140.0 137.0 176.0 144.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.50 stddev:2.88 (1.6%) stddev-sans-first:2.99 15:50:51 INFO - PROCESS | 22980 | Values: 181.0 181.0 183.0 179.0 180.0 177.0 184.0 176.0 177.0 176.0 15:50:51 INFO - PROCESS | 22980 | 15:50:51 INFO - PROCESS | 22980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:4.05 (5.6%) stddev-sans-first:4.24 15:50:51 INFO - PROCESS | 22980 | Values: 71.0 72.0 71.0 74.0 75.0 73.0 83.0 70.0 69.0 70.0 15:50:51 INFO - PROCESS | 22980 | -------- Summary: end -------- 15:50:51 INFO - PROCESS | 22980 | 15:50:52 INFO - TEST-INFO | 22980: exit 0 15:50:52 INFO - TEST-OK | kraken | took 64997ms 15:50:52 INFO - SUITE-END | took 1187s 15:50:52 INFO - Completed test suite (00:19:47) 15:50:52 INFO - javascript benchmark 15:50:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.437143828358, 2569.781568566672, 2605.921822345329, 2623.75074367935, 2630.8421494710315, 4539.137563862863, 4615.423072115986, 4717.811287548494, 4730.219513780226, 4736.7868445919885, 4651.581357677808, 4684.554967278112, 4702.0360826030665, 4748.643851711126, 4788.114198873202, 4336.566343365654, 4367.475902891641, 4411.80146893389, 4428.158649856517, 4430.091831174617, 4422.6240769534625, 4490.595846373826, 4495.303227999665, 4505.189065968125, 4516.164509565724, 4252.723572967747, 4382.101669157815, 4395.318725597537, 4402.1195760847795, 4507.00845813922, 4258.212230737324, 4298.398224248608, 4341.652667786601, 4347.934780978288, 4357.825686972517, 4310.267254566731, 4321.697481176319, 4337.63130133939, 4379.211741886459, 4390.517043125254, 4701.224297990828, 4732.574068333866, 4736.478987311393, 4747.95252047482, 4789.353437285957, 4907.533784290486, 4956.306117143603, 5058.266551350033, 5062.82280120194, 5114.565261952738, 5157.742112894341, 5157.742112894341, 5163.044836705221, 5203.271541984125, 5208.921866172011, 4765.833195838129, 4771.832985845548, 4773.498782627844, 4778.211595086772, 4851.781669824866, 5079.5428411443145, 5130.230465430141, 5148.819791307361, 5243.895122097613, 5309.8938021239355, 4943.357363542788, 4965.32968049316, 4967.950320496749, 5013.523715247045, 5024.221245706921, 5055.09008378488, 5061.089003979319, 5063.493650634907, 5067.366579177603, 5131.512506311969, 4838.056578967138, 4872.926906096412, 4998.150314446553, 5006.89986200274, 5009.348784658044, 4895.583875370633, 4939.2838038484215, 4948.233023881304, 4950.232713929347, 4988.925166122511, 4175.791210439465, 4182.372644103348, 4186.727862688916, 4187.43469631602, 4234.470691163605, 3665.303592317451, 3668.2296717689583, 3672.265546890633, 3672.559292884871, 3694.390425579803, 4356.085222103394, 4407.911841763147, 4409.977950110229, 4413.073254616503, 4415.337699345059, 5066.138756411419, 5097.388313402341, 5101.8724531886255, 5113.718745469035, 5118.436971933084, 4364.279893817548, 4397.164538737629, 4400.647948164139, 4415.205263052617, 4460.0, 4523.5250298718165, 4532.3654688342995, 4534.433195850519, 4534.79593418297, 4587.931181032287, 4751.809927602857, 4753.191957367325, 4791.904161916742, 4810.518948105161, 4865.6107511398295, 4903.485134060872, 4964.67729597575, 5074.238864170256, 5112.693238405707, 5115.74421278942, 4807.326974223542, 4845.3216549683775, 4847.975760121177, 4889.462159162418, 4896.877578060577, 5020.046191223656, 5029.446760856376, 5031.723255220998, 5032.043911656773, 5034.521720436553, 4782.234842425195, 4876.073546026244, 5053.29253904461, 5071.1632580625255, 5073.34046573943, 4955.058538877602, 4983.327250821093, 4989.2516122580455, 4991.600671946163, 5024.924626130538, 4966.553010229097, 4968.080905032581, 4969.875753106201, 4980.028894365564, 5021.874453138701, 4728.148933192058, 4766.571008609242, 4772.284157376422, 4786.970801277742, 4932.506749325039, 4948.802047918043, 4980.651354405157, 4983.0, 5037.546620804145, 5038.420581633159, 4871.585915197106, 4874.4150701916, 4893.143699852582, 4947.777350019186, 4951.207806750903], "value": 4647.494923319119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1990733343985, 560.974756135974, 584.3980699879123, 585.1895125251525, 593.9753924480269, 28116.43767124659, 38966.415503767465, 40107.59892401075, 40211.39682904755, 43334.13331733371, 40400.0, 40932.18135637286, 41008.0, 41023.0, 41035.794821025855, 7616.466847320689, 7748.845023099535, 7755.1081625613215, 7758.0, 7761.146273909865, 7634.809129771745, 7649.082110146763, 7653.961730191341, 7722.189170137139, 7730.342920851735, 7709.922900770976, 7765.339946104559, 7772.300492955633, 7773.455858089936, 7778.183290754474, 7662.923370766304, 7692.923070769277, 7698.2686644768655, 7700.11448683403, 7708.229177082303, 7621.3902887768845, 7663.655135518859, 7678.769636910902, 7681.923180768176, 7685.577293248869, 37870.0, 38207.66273180453, 38217.80891095527, 38236.23527529434, 38256.234875302616, 2982.2246215983782, 3057.2356910772305, 3075.123589776903, 3272.9035773016067, 3300.6204286506877, 27844.30389240285, 27991.580126298122, 28172.0, 28225.0, 29694.554581681077, 2982.6719060903283, 3041.1332770160398, 3063.7395821355212, 3084.784065115443, 3113.8598763055716, 244811.0, 245353.0, 246278.0, 246354.7682261595, 246997.0, 49391.25913111306, 49785.50214497881, 49839.75080124576, 49847.50152498501, 49953.0, 32874.67125328764, 33787.32425351528, 33824.83087584595, 35295.11762205965, 35367.4694879577, 11194.496247668874, 11274.323540587427, 11295.830562541403, 11308.830367544493, 11340.262882912584, 10287.0, 10350.482475876175, 10357.63748268807, 10358.896411035794, 10364.792704145875, 17659.29362825498, 17683.55791105207, 17693.38073167433, 17741.201645925965, 17782.0, 6632.403083722488, 6829.112215411965, 7010.298970103051, 7020.92979070213, 7023.262557431498, 776.4991580430591, 863.8574635185249, 871.0897112517434, 873.3362644390309, 910.0444533240071, 26372.736272637027, 27440.313992150357, 27486.18094219465, 27746.583801242996, 28239.57640635392, 779.3842864137381, 901.2834796336928, 911.2618778789202, 992.6178421307849, 1009.5860697114148, 13865.306734663227, 14891.106533608017, 14993.175375354242, 15258.237088145548, 15276.923615381851, 371275.0, 371633.0, 371681.0, 372045.0, 372969.0, 48158.518414816106, 48562.5143748565, 48599.514004860204, 48692.75653621709, 48757.0, 1067.2049323254225, 1079.4494807648157, 1080.8324709670014, 1149.3391300002531, 1160.4023927677254, 25907.0, 28516.0, 30645.54031689571, 31392.215194620316, 31928.201794955312, 45265.32102018538, 45747.0, 45904.31143532783, 46053.76973115113, 46088.0, 264002.0, 264795.0, 265634.0, 265766.0, 266204.0, 22020.0, 22605.0, 22704.88647556818, 22729.659055114516, 24493.142740004016, 41483.58516414918, 41545.79227103845, 41604.58395416128, 42282.36576451294, 42701.57298426976, 35044.47433288554, 35683.46474802828, 35905.82047089748, 36017.0, 36827.0, 35772.64227357797, 35833.28333433369, 35854.64145358513, 35979.28041439209, 36300.81849590735, 35044.69195544827, 35401.114972125906, 35532.467012995345, 35617.64382356143, 35674.28651426905, 30552.388952221274, 32310.0, 32362.35275294528, 32527.34945301128, 32914.83542582272, 24368.0, 25042.62436063497, 25048.0, 25286.747132529174, 25338.619920700836], "value": 16784.450280997087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.2770182616504, 364.4369449200986, 370.57013863917854, 376.43346763121497, 384.84606157536984, 12133.696657583565, 12267.429374670544, 13582.3208839558, 14433.494827681034, 16865.07242101684, 15853.20733963303, 16034.518964431056, 16167.83832161678, 16171.595710107253, 16256.51230463085, 4869.440014398354, 4916.360873086503, 5056.494350564951, 5061.6962982221185, 5127.512886275797, 3568.3933731265747, 3789.905252368699, 4967.00659868026, 5052.520010598987, 5059.064073146461, 3808.086059345751, 3812.504374431334, 3814.1608846053823, 5548.805791797288, 5901.586888917777, 4989.426215985171, 5242.659227150261, 5918.1418694289305, 5952.077427998667, 5954.821355359346, 5066.620003499752, 5074.873128171826, 5075.720835354054, 5076.060928728197, 5080.466551012164, 11272.15458840582, 11301.378424186667, 11521.827172592419, 11638.185327027111, 11742.823857642057, 1812.664657038452, 1845.1143451143391, 1854.9629007419776, 1904.1050706168078, 2045.7238272833274, 8627.482351058956, 8861.379703420764, 9199.218066464358, 10507.632232871812, 13026.218426894417, 1697.1429428138833, 1742.9564260893453, 1762.118940529735, 1768.4694591622463, 1792.4622613215984, 64403.0, 65612.67193664049, 65674.0, 65793.67103164502, 66338.0, 9452.90547094534, 9488.525573721286, 9653.324267301221, 9711.417314961125, 9766.46284454362, 13133.540326088541, 13137.978264999103, 13164.539241126706, 13165.407556659973, 13169.0, 6772.52592318533, 6925.307469253135, 6929.930700693029, 7082.362587367059, 7149.642517874086, 6533.705983230766, 6595.703193356215, 6718.66406679664, 6770.356816102462, 6842.247352791289, 4025.5571887092397, 4063.898402539901, 4090.202410529918, 4094.9181016379507, 4192.4759405074365, 1767.6729804986119, 1806.4915795310799, 1820.4447643468604, 1839.0988415676222, 1865.822746839048, 808.6967387229789, 813.979650508742, 861.8965724113147, 905.3345790843724, 917.0508523677961, 15692.529224123295, 15835.366585336458, 15905.920470397805, 16247.918760406123, 16432.75350869738, 821.8865717217492, 862.8533149364623, 870.9042005379404, 871.3595507302127, 914.2868562521244, 8846.292296616255, 8927.075437826687, 9291.62833486653, 9302.674406395743, 9313.44119352841, 359817.0, 361325.3968253968, 366441.6711665805, 366737.0, 368138.0, 68452.657736711, 73335.0, 74700.0, 75054.0, 77212.0, 839.8278352937633, 861.0958493581714, 863.2834747159842, 864.2394692670409, 868.1188593577524, 14171.362288696828, 14216.715665686836, 14311.0, 14334.354954027302, 14953.700925981637, 24494.265172044867, 35115.64884351124, 35610.0, 36046.459303111, 36285.45571816372, 46191.76904115458, 46255.0, 46493.53506464892, 46887.531124688314, 49898.25152622786, 7342.9632851835395, 7388.926110739038, 7418.777436676908, 7419.406447484296, 7465.514741541782, 10622.628208012991, 10997.285176463503, 11063.557457701601, 11288.830667540158, 11337.829932550854, 8195.46729462583, 8781.29749620016, 8898.73303800887, 9063.456192628464, 10175.643852465424, 8840.071792461698, 9229.953850230706, 9598.280128990215, 9646.062927659412, 9913.355631883904, 9224.262059035127, 9293.907060929305, 9359.672411465566, 9438.622455101993, 9694.369865958972, 7067.646617668993, 7105.467089968376, 7179.246179151114, 7181.856362872609, 7233.529820561646, 7611.391088712779, 9268.95365523168, 9276.610950093474, 9508.572114255014, 9550.665726699532], "value": 7651.348292545352, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.059104194249, 1284.6916739982405, 1361.3873756809435, 1363.51376999071, 1678.4041665208852, 6811.352921472459, 7627.3898088152955, 7897.526148431091, 7905.0, 8120.228578285069, 7893.526388416699, 7954.880676789853, 7962.800929976739, 7965.203479652032, 7968.721094761684, 2141.3468891987936, 2161.632522471176, 2173.6413491773837, 2177.3032629558547, 2185.573813106445, 2084.0725876984748, 2125.203048856679, 2158.8272938164987, 2160.2979031814725, 2165.2096984600585, 2151.505153814616, 2155.5365596396773, 2171.1315473810446, 2177.1835561664375, 2202.4053505553493, 2128.8190503807195, 2130.414136112581, 2137.7434707835005, 2139.4116617930194, 2139.8609090409072, 2047.9897600511902, 2085.780992995744, 2091.288961752996, 2092.1735914313763, 2112.41908475169, 7736.883946740803, 7870.527768333918, 7904.841903161962, 7957.124716281204, 7966.760997170094, 4322.113966636832, 4510.075434535912, 4520.773961301955, 4522.050369422425, 4524.660650451229, 2567.127176759892, 2665.8533780642056, 2690.4753573053263, 2699.20373489821, 2707.187843646918, 744.0847757258603, 745.8955746195537, 756.916739158692, 759.8176437654978, 759.9126100498459, 10798.136149108053, 10908.836367454414, 10942.781144377148, 10952.99999999992, 10978.835317470244, 3874.535055793323, 3980.283548961157, 4107.445494858156, 4127.33962565988, 4132.710710250314, 8258.298044666151, 8261.421700480909, 8269.173082691683, 8269.21442462965, 8286.295664868554, 4332.935005974913, 4342.196693611692, 4344.847930322424, 4344.869653910388, 4346.6308112944325, 3534.8939531814085, 3630.7821530708243, 3876.7867767272505, 3988.4017397390626, 3991.980040099781, 3352.078178500883, 3388.3053973935284, 3498.2303893143467, 3500.982495087559, 3504.684578387906, 953.9379940303858, 976.038601977052, 976.4043933200742, 978.2516374973151, 980.9313348065709, 797.4218691448654, 800.203797221768, 801.418971245842, 805.814662627599, 823.6087858267275, 4829.589484893753, 4936.605071594264, 4954.430240522314, 5060.671056381323, 5172.844814655491, 345.9429194182982, 347.298457116623, 348.0550305919441, 348.621745406232, 351.13795631724054, 3223.323102148528, 3406.0803583032443, 3431.9142021449165, 3453.2748122893972, 3477.078574177845, 9211.0, 9552.235821134293, 9584.424934503952, 9817.410955342702, 9859.901400986042, 9736.123748862636, 9738.951305243429, 9740.318177727633, 9759.365641233297, 9765.121139097515, 6954.478414118961, 7156.856862862818, 7158.176809666851, 7160.140783105957, 7160.248173941765, 4980.950190498049, 4988.900221995613, 5075.137226671401, 5104.2343648453025, 5128.769205385692, 8499.10759370282, 8624.0, 8629.827403452022, 8695.782605434915, 8733.519656418957, 8650.697225597074, 8712.128787121237, 8877.28981681451, 8881.0, 8908.331875109523, 5866.941330586639, 6647.634380109141, 6776.6950487227205, 6778.389944904982, 6780.830479238059, 6646.202455705346, 7362.447816413897, 7452.105747310357, 7643.541387516767, 7647.158812530728, 6420.582662126947, 6580.177477815273, 6640.468762499085, 6643.867122657616, 6697.3302669734585, 6618.271990080991, 6664.66676666155, 6718.93281067183, 6791.286914874065, 6840.41856442208, 6001.549883758823, 6067.089936509559, 6073.544484163617, 6075.908861367171, 6080.2399700037495, 4412.536683648171, 4581.63346932238, 4619.376384188226, 4626.1904166771355, 4644.465886423104, 4477.977610111929, 4563.429571303587, 4673.836415725434, 4676.7661616919695, 4802.039592081528], "value": 3896.1566590894827, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.51950599781355, 301.3520930000499, 304.5523081070826, 307.6846232611574, 307.89069880192517, 4765.666403351766, 4775.904481910364, 4792.472827988919, 4831.444383895853, 4843.636727245462, 4775.5912005958235, 4782.928256076161, 4789.760511974405, 4796.057596673353, 4812.205986012304, 3578.5884623268266, 3681.521402217708, 3686.668199862012, 3769.453429252757, 3795.5065841440573, 3799.639034291738, 3803.1633040730994, 3814.5994670559608, 3819.3888977763563, 3832.6742226910746, 3742.513473248474, 3781.73527853049, 3785.6782173515285, 3805.6194380562, 3812.3519001769764, 3576.356255873942, 3621.2938476996997, 3694.704423646102, 3738.420544815558, 3755.286495565834, 3312.850921708529, 3316.303576248991, 3318.7179089777396, 3320.96679033209, 3334.3998080345527, 4647.070585882837, 4647.23320652092, 4651.465081515636, 4651.976740116278, 4663.183942809995, 4202.201581699467, 4278.2940814765525, 4294.398784170218, 4317.633001194902, 4327.0913108247305, 4962.429320628102, 4979.7261150636705, 4983.875403114951, 5000.549950504472, 5003.0, 3637.217998130415, 3652.6347365263528, 3659.1949771050326, 3662.7252956028137, 3673.8163091845568, 5148.742562871879, 5156.051412152781, 5227.973860130675, 5263.789448422059, 5279.366476022863, 3713.628637136265, 3763.096856754359, 3786.5645450773513, 3805.5813860475328, 3808.27642747877, 3845.634934515253, 3858.6913046956174, 3860.4595356650093, 3861.4400911868183, 3863.4204869269274, 4346.869593912124, 4359.738415695068, 4365.454318210223, 4375.365571992043, 4378.890527736832, 4948.480409557017, 4986.501349865057, 5037.858909963251, 5065.0, 5102.540771330524, 1295.4429595274123, 1314.4479318686174, 1318.6044186743939, 1319.3732976835927, 1324.8343957005375, 821.6097353756918, 852.5268475995758, 856.4818284937647, 871.3464901324007, 871.9389642724948, 4237.851675191354, 4336.392904993303, 4408.977955110268, 4484.260097083945, 4506.954930450719, 5144.356955380577, 5155.53600175986, 5166.0, 5188.844334669966, 5192.402873669576, 4494.887627809331, 4496.235639941217, 4503.626393949877, 4509.819607215674, 4520.118576877543, 2595.766381025717, 2729.235813972091, 2734.5214587447517, 2740.0, 2743.3278846682692, 4895.0, 4895.192293271571, 4901.828436004723, 4909.189983652729, 4948.480409556944, 5051.191809310492, 5288.7355632219005, 5292.655977361459, 5292.947070529245, 5319.867003324948, 4902.28916807061, 4908.828191013297, 4928.260760885824, 4928.901421971541, 4954.380702412199, 5060.165072762953, 5120.231965205249, 5137.460566640599, 5163.845084647466, 5185.299984502044, 4855.67386340358, 5066.847994560169, 5100.934121680725, 5110.390227078458, 5116.616253780907, 4933.284673722362, 4949.802007919643, 4962.404511458648, 4963.429205641398, 4970.403551573834, 3623.7463377563317, 3639.363111455538, 3646.762960407565, 3671.1556342040944, 3682.4660424238873, 5105.566026887756, 5294.073537131064, 5301.125314323093, 5308.548773354154, 5308.814191503433, 5020.47285035066, 5021.44764075944, 5059.291699162047, 5070.898582028412, 5087.720175390389, 5038.596912246938, 5054.494550544916, 5055.418626857959, 5096.490350964874, 5096.872578185575, 4682.648801339981, 4976.452590215146, 4984.651074424755, 4994.775235114501, 5009.298698182331, 4879.414470263449, 5002.349694539686, 5003.724795136302, 5072.213806859942, 5102.36220472441, 4951.5791157750555, 4979.153543897473, 4988.152014157529, 4989.675671081368, 4993.850184494471], "value": 3814.340631182661, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7839988404232, 591.7987884119399, 646.5861848417014, 647.5920170292715, 672.4754691340756, 11427.42862856857, 11755.294682319056, 11863.228890122136, 11996.880031199686, 12112.818307725369, 10973.341599504016, 11780.293182409061, 11832.29006259625, 11871.109666775004, 11892.167548271624, 614.0758158970742, 741.2920660768966, 761.8362052158785, 762.9351505122071, 765.0551568812513, 619.1734035063173, 740.9296116868888, 758.4122305213476, 763.0881097088981, 771.0554570650936, 811.2050190812977, 814.2712272516095, 814.9266566009057, 814.9511029338229, 815.339574944297, 642.8714257148589, 805.3919290935365, 806.0247101007758, 806.310604433207, 806.6773290683715, 485.8032496838786, 561.1862798941511, 571.1119209629026, 572.0732413490173, 579.8086631411624, 11117.610883619034, 11574.363410012445, 11580.536778528849, 11580.826287605692, 11589.536418543248, 10829.83755243672, 11063.557457701681, 11071.72320691981, 11541.884581154165, 11703.23928944616, 10085.0, 10086.49567521621, 10226.586931475353, 10288.382697038202, 10422.9478852606, 4042.535108462535, 4053.7567745935044, 4054.2499637567144, 4055.5336136344404, 4118.711690181688, 59123.704381477815, 59909.7004514979, 60490.39509604892, 60843.39156608466, 61700.69149654268, 9726.416415015121, 9747.658831940847, 9818.067283608189, 9902.55438505269, 9973.351732137387, 16154.596135096717, 17000.82999170017, 17954.820451795575, 17959.461216163538, 17981.910090449463, 6674.365935236145, 6696.19645642526, 6817.386435220854, 6870.27862074485, 6941.757038503729, 3463.930721385558, 3475.878344257939, 3499.3701133795653, 3539.911502212414, 3658.0854786303425, 2900.318425170083, 3012.834294113845, 3018.5321275202377, 3025.6066711327385, 3026.031669865622, 493.6396430605606, 499.5903359245384, 501.1830715933006, 501.44840675256927, 512.9410117836496, 452.3215177234149, 517.3248910172262, 518.9558887494605, 539.8893226888479, 543.2204786131913, 7523.322900938832, 7533.924660753432, 7611.961940190264, 7931.524108553505, 8169.959150204211, 474.26488942140236, 493.44980346912934, 501.6939666803247, 506.71370675568187, 509.1573445946964, 3401.880934167342, 3452.430348992438, 3695.0577602711674, 3716.3394056853977, 3774.7735135891935, 54402.72798636061, 98124.0, 99185.50407247918, 100171.0, 102781.48609256906, 84454.57772711097, 85011.0, 86683.0, 87625.56187219151, 87810.56094719486, 76977.6151119252, 78559.60720196362, 78953.60523197347, 79168.60415697885, 79670.82139661019, 6776.93223067763, 7040.852188633985, 7107.111611048619, 7281.2718728126765, 7388.778336649909, 43445.74530839257, 43608.0, 43861.0, 45383.0, 45759.0, 60450.0, 63538.364616355095, 63846.68076659587, 64339.67830160819, 66270.8170895076, 9644.903550964682, 9752.122308992224, 9915.314570772893, 10085.747856303651, 10259.58961641526, 9477.194438472807, 9669.516524173903, 9903.900960990299, 9935.20518358515, 10107.241956853413, 8495.362847786564, 10012.148967337858, 10045.799084018425, 10284.845727313947, 10659.147268218368, 8955.955220223857, 9772.560234789593, 9963.153131983863, 9966.651167209113, 10004.899951000396, 10082.143017843273, 10461.05850473461, 10506.842397364198, 10538.631147909786, 10592.0, 8564.314854811475, 8609.455150422787, 8683.782905427415, 8960.731178064669, 9238.399504032217, 9077.137671921157, 9244.567092100735, 9248.260139188984, 9301.813963720822, 9429.81140377175], "value": 6137.3054108709, "unit": "score"}], "name": "dromaeo_css", "value": 6156.365868714454, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 112.0, 112.0, 113.0, 114.0, 113.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 127.0, 169.0, 132.0, 130.0, 134.0, 135.0, 162.0, 129.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 164.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 101.0, 76.0, 76.0, 76.0, 77.0, 106.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 82.0, 83.0, 84.0, 119.0, 83.0, 83.0, 109.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 149.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 63.0, 63.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 68.0, 66.0, 70.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 83.0, 83.0, 83.0, 90.0, 82.0, 83.0, 83.0, 84.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 141.0, 142.0, 148.0, 148.0, 154.0, 140.0, 137.0, 176.0, 144.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 183.0, 179.0, 180.0, 177.0, 184.0, 176.0, 177.0, 176.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 74.0, 75.0, 73.0, 83.0, 70.0, 69.0, 70.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1563.8000000000002, "alertThreshold": 2.0}]} 15:50:52 INFO - Return code: 0 15:50:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:50:52 INFO - # TBPL SUCCESS # 15:50:52 INFO - Running post-action listener: _resource_record_post_action 15:50:52 INFO - [mozharness: 2016-10-01 22:50:52.969334Z] Finished run-tests step (success) 15:50:52 INFO - Running post-run listener: _resource_record_post_run 15:50:53 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 390569984; Read time: 0; Write time: 318608 15:50:53 INFO - TinderboxPrint: CPU usage
13.0% 15:50:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:50:53 INFO - TinderboxPrint: I/O write bytes / time
390,569,984 / 318,608 15:50:53 INFO - TinderboxPrint: CPU idle
8,354.7 (87.0%) 15:50:53 INFO - TinderboxPrint: CPU user
1,201.6 (12.5%) 15:50:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:50:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99164160; Read time: 0; Write time: 74772 15:50:53 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291405824; Read time: 0; Write time: 243836 15:50:53 INFO - Running post-run listener: _upload_blobber_files 15:50:53 INFO - Blob upload gear active. 15:50:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:50:53 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 15:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:50:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:50:54 INFO - (blobuploader) - INFO - Done attempting. 15:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:50:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:50:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:50:58 INFO - (blobuploader) - INFO - Done attempting. 15:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:50:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:50:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:50:59 INFO - (blobuploader) - INFO - Done attempting. 15:50:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:50:59 INFO - Return code: 0 15:50:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:50:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:50:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25db72411787a916c6156a2fd63c1ac619879e63514b78ee7f163e9a1b3309adfa7c2c1276c1edb951f09f1729271cc6de77587cec1fc972692c665706de24e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46946b0588832df41ecf1a9f1c6c1b36d8d2d0a1fcd63de56ecdb9831687da94533fd57c2542efc1dfd24fd6269b7ca8e786f0d1ae09eb65337b64e8d71af071", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bea20c983bc0b605f6e404d160f34a74d07405a602fea646f33cc522f68f39ea11bd643aabb6ea506ee72b8a86c61a119237c68c6eb6b10d410d576ded46854"} 15:50:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:50:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:50:59 INFO - Contents: 15:50:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25db72411787a916c6156a2fd63c1ac619879e63514b78ee7f163e9a1b3309adfa7c2c1276c1edb951f09f1729271cc6de77587cec1fc972692c665706de24e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46946b0588832df41ecf1a9f1c6c1b36d8d2d0a1fcd63de56ecdb9831687da94533fd57c2542efc1dfd24fd6269b7ca8e786f0d1ae09eb65337b64e8d71af071", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bea20c983bc0b605f6e404d160f34a74d07405a602fea646f33cc522f68f39ea11bd643aabb6ea506ee72b8a86c61a119237c68c6eb6b10d410d576ded46854"} 15:50:59 INFO - Running post-run listener: copy_logs_to_upload_dir 15:50:59 INFO - Copying logs to upload dir... 15:50:59 INFO - mkdir: /builds/slave/test/build/upload/logs 15:50:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.577783 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-01 15:50:56.797400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 15:50:56.801213) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25db72411787a916c6156a2fd63c1ac619879e63514b78ee7f163e9a1b3309adfa7c2c1276c1edb951f09f1729271cc6de77587cec1fc972692c665706de24e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46946b0588832df41ecf1a9f1c6c1b36d8d2d0a1fcd63de56ecdb9831687da94533fd57c2542efc1dfd24fd6269b7ca8e786f0d1ae09eb65337b64e8d71af071", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bea20c983bc0b605f6e404d160f34a74d07405a602fea646f33cc522f68f39ea11bd643aabb6ea506ee72b8a86c61a119237c68c6eb6b10d410d576ded46854"} build_url:https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011513 build_url: 'https://queue.taskcluster.net/v1/task/akp5ulf7RQavy_DfCGoRlA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25db72411787a916c6156a2fd63c1ac619879e63514b78ee7f163e9a1b3309adfa7c2c1276c1edb951f09f1729271cc6de77587cec1fc972692c665706de24e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46946b0588832df41ecf1a9f1c6c1b36d8d2d0a1fcd63de56ecdb9831687da94533fd57c2542efc1dfd24fd6269b7ca8e786f0d1ae09eb65337b64e8d71af071", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bea20c983bc0b605f6e404d160f34a74d07405a602fea646f33cc522f68f39ea11bd643aabb6ea506ee72b8a86c61a119237c68c6eb6b10d410d576ded46854"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 15:50:56.831940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:50:56.832298) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475351825.728685-1658273849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:50:56.914014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 15:50:56.914381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 15:50:56.914722) ========= ========= Total master_lag: 0.16 =========