builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1475524148.03 results: success (0) buildid: 20161003115257 builduid: 0e99cde49a914f75977908814daa20ce revision: 27f488a1f9efa704afc98f2319aca94eaed4b32d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.027145) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.027893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.028215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.113913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.114357) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 12:49:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-10-03 12:49:08 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178637 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.349592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.349922) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.067993 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.430466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:08.430838) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 27f488a1f9efa704afc98f2319aca94eaed4b32d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 27f488a1f9efa704afc98f2319aca94eaed4b32d --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=78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 12:49:08,506 truncating revision to first 12 chars 2016-10-03 12:49:08,506 Setting DEBUG logging. 2016-10-03 12:49:08,506 attempt 1/10 2016-10-03 12:49:08,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/27f488a1f9ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 12:49:08,873 unpacking tar archive at: autoland-27f488a1f9ef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:09.164244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:09.164765) ========= script_repo_revision: 27f488a1f9efa704afc98f2319aca94eaed4b32d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:09.165387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:09.165845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:49:09.174405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-10-03 12:49:09.174914) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:49:09 INFO - MultiFileLogger online at 20161003 12:49:09 in /builds/slave/test 12:49:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:49:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:49:09 INFO - {'append_to_log': False, 12:49:09 INFO - 'base_work_dir': '/builds/slave/test', 12:49:09 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:49:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:49:09 INFO - 'branch': 'Autoland-Non-PGO', 12:49:09 INFO - 'buildbot_json_path': 'buildprops.json', 12:49:09 INFO - 'config_files': ('talos/linux_config.py',), 12:49:09 INFO - 'default_actions': ('clobber', 12:49:09 INFO - 'read-buildbot-config', 12:49:09 INFO - 'download-and-extract', 12:49:09 INFO - 'populate-webroot', 12:49:09 INFO - 'create-virtualenv', 12:49:09 INFO - 'install', 12:49:09 INFO - 'run-tests'), 12:49:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:49:09 INFO - 'download_minidump_stackwalk': True, 12:49:09 INFO - 'download_symbols': 'ondemand', 12:49:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:49:09 INFO - 'tooltool.py': '/tools/tooltool.py', 12:49:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:49:09 INFO - '/tools/misc-python/virtualenv.py')}, 12:49:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:49:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:49:09 INFO - 'installer_path': 'installer.exe', 12:49:09 INFO - 'log_level': 'info', 12:49:09 INFO - 'log_name': 'talos', 12:49:09 INFO - 'log_to_console': True, 12:49:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:49:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:49:09 INFO - 'opt_config_files': (), 12:49:09 INFO - 'pip_index': False, 12:49:09 INFO - 'sps_profile': False, 12:49:09 INFO - 'sps_profile_interval': 0, 12:49:09 INFO - 'suite': 'dromaeojs', 12:49:09 INFO - 'system_bits': '32', 12:49:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:49:09 INFO - 'title': 'talos-linux64-ix-019', 12:49:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:49:09 INFO - 'use_talos_json': True, 12:49:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:49:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:49:09 INFO - 'work_dir': 'build'} 12:49:09 INFO - [mozharness: 2016-10-03 19:49:09.456427Z] Running clobber step. 12:49:09 INFO - Running pre-action listener: _resource_record_pre_action 12:49:09 INFO - Running main action method: clobber 12:49:09 INFO - rmtree: /builds/slave/test/build 12:49:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:49:13 INFO - Running post-action listener: _resource_record_post_action 12:49:13 INFO - [mozharness: 2016-10-03 19:49:13.786884Z] Finished clobber step (success) 12:49:13 INFO - [mozharness: 2016-10-03 19:49:13.787042Z] Running read-buildbot-config step. 12:49:13 INFO - Running pre-action listener: _resource_record_pre_action 12:49:13 INFO - Running main action method: read_buildbot_config 12:49:13 INFO - Using buildbot properties: 12:49:13 INFO - { 12:49:13 INFO - "project": "", 12:49:13 INFO - "product": "firefox", 12:49:13 INFO - "script_repo_revision": "production", 12:49:13 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:49:13 INFO - "repository": "", 12:49:13 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:49:13 INFO - "buildid": "20161003115257", 12:49:13 INFO - "pgo_build": "False", 12:49:13 INFO - "basedir": "/builds/slave/test", 12:49:13 INFO - "buildnumber": 752, 12:49:13 INFO - "slavename": "talos-linux64-ix-019", 12:49:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:49:13 INFO - "platform": "ubuntu64_hw", 12:49:13 INFO - "scheduler": "tests-autoland-linux64-talos", 12:49:13 INFO - "branch": "autoland", 12:49:13 INFO - "repo_path": "integration/autoland", 12:49:13 INFO - "revision": "27f488a1f9efa704afc98f2319aca94eaed4b32d", 12:49:13 INFO - "stage_platform": "linux64", 12:49:13 INFO - "builduid": "0e99cde49a914f75977908814daa20ce", 12:49:13 INFO - "slavebuilddir": "test" 12:49:13 INFO - } 12:49:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:49:13 INFO - Running post-action listener: _resource_record_post_action 12:49:13 INFO - [mozharness: 2016-10-03 19:49:13.790942Z] Finished read-buildbot-config step (success) 12:49:13 INFO - [mozharness: 2016-10-03 19:49:13.791083Z] Running download-and-extract step. 12:49:13 INFO - Running pre-action listener: _resource_record_pre_action 12:49:13 INFO - Running main action method: download_and_extract 12:49:13 INFO - mkdir: /builds/slave/test/build/tests 12:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:13 INFO - trying https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:49:13 INFO - Downloading https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/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 12:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/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 12:49:14 INFO - Downloaded 1361 bytes. 12:49:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:49:14 INFO - Using the following test package requirements: 12:49:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:49:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:49:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:49:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'jsshell-linux-x86_64.zip'], 12:49:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:49:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:49:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:49:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:49:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:49:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:49:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:49:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:49:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:49:14 INFO - Fetch https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:49:14 INFO - Http code: 200 12:49:14 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 12:49:14 INFO - x-amz-cf-id: twmPEf3OrDTflrL1ohetE_vSDA_3TsumwQyvhNGQX8FoN1sdI3B7_Q== 12:49:14 INFO - x-amz-version-id: TEcWWjNkbDWs7ns2h5igmtDuPsKqoUuk 12:49:15 INFO - Expected file size: 20420645 12:49:15 INFO - Obtained file size: 20420645 12:49:19 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 12:49:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:49:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:49:19 INFO - Fetch https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:49:20 INFO - Http code: 200 12:49:20 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 12:49:20 INFO - x-amz-cf-id: FuzuwmHIoxN1pbIcfsvEr9WaUlwk00FbEVdAZJHzcLrvPym2SFBl0w== 12:49:20 INFO - x-amz-version-id: TEcWWjNkbDWs7ns2h5igmtDuPsKqoUuk 12:49:20 INFO - Expected file size: 20420645 12:49:20 INFO - Obtained file size: 20420645 12:49:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:49:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:49:24 INFO - Fetch https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:49:25 INFO - Http code: 200 12:49:25 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 12:49:25 INFO - x-amz-cf-id: EITIRIoWyhGSb3jooWM6956d_eMZJY3U1sJ6P2HrFZEHnGvT4cLSMw== 12:49:25 INFO - x-amz-version-id: 9sXONlq.NRl4LDHBNSsepxNwMlxuA1qA 12:49:25 INFO - Expected file size: 14408522 12:49:25 INFO - Obtained file size: 14408522 12:49:25 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')]} 12:49:25 INFO - trying https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:49:25 INFO - Downloading https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/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 12:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/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 12:49:27 INFO - Downloaded 55824129 bytes. 12:49:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:49:27 INFO - mkdir: /builds/slave/test/properties 12:49:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:49:27 INFO - Writing to file /builds/slave/test/properties/build_url 12:49:27 INFO - Contents: 12:49:27 INFO - build_url:https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:49:27 INFO - Running post-action listener: _resource_record_post_action 12:49:27 INFO - Running post-action listener: set_extra_try_arguments 12:49:27 INFO - [mozharness: 2016-10-03 19:49:27.974327Z] Finished download-and-extract step (success) 12:49:27 INFO - [mozharness: 2016-10-03 19:49:27.974553Z] Running populate-webroot step. 12:49:27 INFO - Running pre-action listener: _resource_record_pre_action 12:49:27 INFO - Running main action method: populate_webroot 12:49:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:49:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:49:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:49:27 INFO - '--tppagecycles', 12:49:27 INFO - '7'], 12:49:27 INFO - 'tests': ['tsvgm']}}, 12:49:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:49:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:49:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:49:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:49:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:49:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:49:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['damp', 'tps']}, 12:49:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'tests': ['damp', 'tps']}, 12:49:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['dromaeo_dom']}, 12:49:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:49:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['basic_compositor_video']}, 12:49:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:49:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['a11yr', 12:49:27 INFO - 'ts_paint', 12:49:27 INFO - 'tpaint', 12:49:27 INFO - 'sessionrestore', 12:49:27 INFO - 'sessionrestore_no_auto_restore', 12:49:27 INFO - 'tabpaint']}, 12:49:27 INFO - 'other-e10s': {'tests': ['a11yr', 12:49:27 INFO - 'ts_paint', 12:49:27 INFO - 'tpaint', 12:49:27 INFO - 'sessionrestore', 12:49:27 INFO - 'sessionrestore_no_auto_restore', 12:49:27 INFO - 'tabpaint']}, 12:49:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:49:27 INFO - 'ts_paint', 12:49:27 INFO - 'tpaint', 12:49:27 INFO - 'sessionrestore', 12:49:27 INFO - 'sessionrestore_no_auto_restore', 12:49:27 INFO - 'tabpaint']}, 12:49:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:49:27 INFO - 'ts_paint', 12:49:27 INFO - 'tpaint', 12:49:27 INFO - 'sessionrestore', 12:49:27 INFO - 'sessionrestore_no_auto_restore', 12:49:27 INFO - 'tabpaint']}, 12:49:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['a11yr', 12:49:27 INFO - 'ts_paint', 12:49:27 INFO - 'tpaint', 12:49:27 INFO - 'sessionrestore', 12:49:27 INFO - 'sessionrestore_no_auto_restore', 12:49:27 INFO - 'tabpaint']}, 12:49:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['a11yr', 12:49:27 INFO - 'ts_paint', 12:49:27 INFO - 'tpaint', 12:49:27 INFO - 'sessionrestore', 12:49:27 INFO - 'sessionrestore_no_auto_restore', 12:49:27 INFO - 'tabpaint']}, 12:49:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['tsvgx', 12:49:27 INFO - 'tsvgr_opacity', 12:49:27 INFO - 'tart', 12:49:27 INFO - 'tscrollx', 12:49:27 INFO - 'cart']}, 12:49:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:49:27 INFO - 'tsvgr_opacity', 12:49:27 INFO - 'tart', 12:49:27 INFO - 'tscrollx', 12:49:27 INFO - 'cart']}, 12:49:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'talos_options': ['--disable-e10s'], 12:49:27 INFO - 'tests': ['tp5o']}, 12:49:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'tests': ['tp5o']}, 12:49:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'talos_options': ['--disable-e10s', 12:49:27 INFO - '--xperf_path', 12:49:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:49:27 INFO - 'tests': ['tp5n']}, 12:49:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:27 INFO - 'talos_options': ['--xperf_path', 12:49:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:49:27 INFO - 'tests': ['tp5n']}}, 12:49:27 INFO - 'talos.zip': {'path': '', 12:49:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:49:27 INFO - Running post-action listener: _resource_record_post_action 12:49:27 INFO - [mozharness: 2016-10-03 19:49:27.993592Z] Finished populate-webroot step (success) 12:49:27 INFO - [mozharness: 2016-10-03 19:49:27.993681Z] Running create-virtualenv step. 12:49:27 INFO - Running pre-action listener: _resource_record_pre_action 12:49:27 INFO - Running main action method: create_virtualenv 12:49:27 INFO - Creating virtualenv /builds/slave/test/build/venv 12:49:27 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 12:49:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:49:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:49:28 INFO - Using real prefix '/usr' 12:49:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:49:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:49:30 INFO - Installing pip.................done. 12:49:30 INFO - Return code: 0 12:49:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:49:31 INFO - Reading from file tmpfile_stdout 12:49:31 INFO - Output received: 12:49:31 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) 12:49:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:49:31 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')]} 12:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:31 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')]} 12:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:31 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:31 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 12:49:31 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 12:49:31 INFO - Using env: {'DISPLAY': ':0', 12:49:31 INFO - 'HOME': '/home/cltbld', 12:49:31 INFO - 'LANG': 'en_US.UTF-8', 12:49:31 INFO - 'LANGUAGE': 'en_US:en', 12:49:31 INFO - 'LOGNAME': 'cltbld', 12:49:31 INFO - 'MAIL': '/var/mail/cltbld', 12:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:31 INFO - 'MOZ_NO_REMOTE': '1', 12:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:31 INFO - 'NO_EM_RESTART': '1', 12:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:31 INFO - 'PWD': '/builds/slave/test', 12:49:31 INFO - 'SHELL': '/bin/bash', 12:49:31 INFO - 'SHLVL': '1', 12:49:31 INFO - 'TERM': 'linux', 12:49:31 INFO - 'TMOUT': '86400', 12:49:31 INFO - 'USER': 'cltbld', 12:49:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:31 INFO - '_': '/tools/buildbot/bin/python'} 12:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:31 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 12:49:31 INFO - Cleaning up... 12:49:31 INFO - Return code: 0 12:49:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:49:31 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')]} 12:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:31 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')]} 12:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:31 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:31 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 12:49:31 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 12:49:31 INFO - Using env: {'DISPLAY': ':0', 12:49:31 INFO - 'HOME': '/home/cltbld', 12:49:31 INFO - 'LANG': 'en_US.UTF-8', 12:49:31 INFO - 'LANGUAGE': 'en_US:en', 12:49:31 INFO - 'LOGNAME': 'cltbld', 12:49:31 INFO - 'MAIL': '/var/mail/cltbld', 12:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:31 INFO - 'MOZ_NO_REMOTE': '1', 12:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:31 INFO - 'NO_EM_RESTART': '1', 12:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:31 INFO - 'PWD': '/builds/slave/test', 12:49:31 INFO - 'SHELL': '/bin/bash', 12:49:31 INFO - 'SHLVL': '1', 12:49:31 INFO - 'TERM': 'linux', 12:49:31 INFO - 'TMOUT': '86400', 12:49:31 INFO - 'USER': 'cltbld', 12:49:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:31 INFO - '_': '/tools/buildbot/bin/python'} 12:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:31 INFO - Downloading/unpacking psutil>=3.1.1 12:49:31 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 12:49:31 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 12:49:31 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 12:49:31 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 12:49:31 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 12:49:31 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 12:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:49:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:49:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:49:33 INFO - Installing collected packages: psutil 12:49:33 INFO - Running setup.py install for psutil 12:49:33 INFO - building 'psutil._psutil_linux' extension 12:49:33 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 12:49:35 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 12:49:35 INFO - building 'psutil._psutil_posix' extension 12:49:35 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 12:49:35 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 12:49:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:49:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:49:35 INFO - Successfully installed psutil 12:49:35 INFO - Cleaning up... 12:49:35 INFO - Return code: 0 12:49:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:49:35 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')]} 12:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:35 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')]} 12:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:35 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:35 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 12:49:35 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 12:49:35 INFO - Using env: {'DISPLAY': ':0', 12:49:35 INFO - 'HOME': '/home/cltbld', 12:49:35 INFO - 'LANG': 'en_US.UTF-8', 12:49:35 INFO - 'LANGUAGE': 'en_US:en', 12:49:35 INFO - 'LOGNAME': 'cltbld', 12:49:35 INFO - 'MAIL': '/var/mail/cltbld', 12:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:35 INFO - 'MOZ_NO_REMOTE': '1', 12:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:35 INFO - 'NO_EM_RESTART': '1', 12:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:35 INFO - 'PWD': '/builds/slave/test', 12:49:35 INFO - 'SHELL': '/bin/bash', 12:49:35 INFO - 'SHLVL': '1', 12:49:35 INFO - 'TERM': 'linux', 12:49:35 INFO - 'TMOUT': '86400', 12:49:35 INFO - 'USER': 'cltbld', 12:49:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:35 INFO - '_': '/tools/buildbot/bin/python'} 12:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:49:37 INFO - Installing collected packages: mozsystemmonitor 12:49:37 INFO - Running setup.py install for mozsystemmonitor 12:49:38 INFO - Successfully installed mozsystemmonitor 12:49:38 INFO - Cleaning up... 12:49:38 INFO - Return code: 0 12:49:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:49:38 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')]} 12:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:38 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')]} 12:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:38 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:38 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 12:49:38 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 12:49:38 INFO - Using env: {'DISPLAY': ':0', 12:49:38 INFO - 'HOME': '/home/cltbld', 12:49:38 INFO - 'LANG': 'en_US.UTF-8', 12:49:38 INFO - 'LANGUAGE': 'en_US:en', 12:49:38 INFO - 'LOGNAME': 'cltbld', 12:49:38 INFO - 'MAIL': '/var/mail/cltbld', 12:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:38 INFO - 'MOZ_NO_REMOTE': '1', 12:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:38 INFO - 'NO_EM_RESTART': '1', 12:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:38 INFO - 'PWD': '/builds/slave/test', 12:49:38 INFO - 'SHELL': '/bin/bash', 12:49:38 INFO - 'SHLVL': '1', 12:49:38 INFO - 'TERM': 'linux', 12:49:38 INFO - 'TMOUT': '86400', 12:49:38 INFO - 'USER': 'cltbld', 12:49:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:38 INFO - '_': '/tools/buildbot/bin/python'} 12:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:38 INFO - Downloading/unpacking jsonschema==2.5.1 12:49:38 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 12:49:38 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 12:49:38 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 12:49:38 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 12:49:38 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 12:49:38 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 12:49:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:49:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:49:40 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 12:49:40 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 12:49:40 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 12:49:40 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 12:49:40 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 12:49:40 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 12:49:40 INFO - Downloading functools32-3.2.3-2.tar.gz 12:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:49:40 INFO - warning: no files found matching '*.txt' 12:49:40 INFO - no previously-included directories found matching 'build' 12:49:40 INFO - no previously-included directories found matching 'dist' 12:49:40 INFO - no previously-included directories found matching '.git*' 12:49:40 INFO - Installing collected packages: jsonschema, functools32 12:49:40 INFO - Running setup.py install for functools32 12:49:40 INFO - warning: no files found matching '*.txt' 12:49:40 INFO - no previously-included directories found matching 'build' 12:49:40 INFO - no previously-included directories found matching 'dist' 12:49:40 INFO - no previously-included directories found matching '.git*' 12:49:40 INFO - Successfully installed jsonschema functools32 12:49:40 INFO - Cleaning up... 12:49:40 INFO - Return code: 0 12:49:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:49: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')]} 12:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:40 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:40 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 12:49:40 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 12:49:40 INFO - Using env: {'DISPLAY': ':0', 12:49:40 INFO - 'HOME': '/home/cltbld', 12:49:40 INFO - 'LANG': 'en_US.UTF-8', 12:49:40 INFO - 'LANGUAGE': 'en_US:en', 12:49:40 INFO - 'LOGNAME': 'cltbld', 12:49:40 INFO - 'MAIL': '/var/mail/cltbld', 12:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:40 INFO - 'MOZ_NO_REMOTE': '1', 12:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:40 INFO - 'NO_EM_RESTART': '1', 12:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:40 INFO - 'PWD': '/builds/slave/test', 12:49:40 INFO - 'SHELL': '/bin/bash', 12:49:40 INFO - 'SHLVL': '1', 12:49:40 INFO - 'TERM': 'linux', 12:49:40 INFO - 'TMOUT': '86400', 12:49:40 INFO - 'USER': 'cltbld', 12:49:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:40 INFO - '_': '/tools/buildbot/bin/python'} 12:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:49:40 INFO - Cleaning up... 12:49:40 INFO - Return code: 0 12:49:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:49: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')]} 12:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:40 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:40 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 12:49:40 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 12:49:40 INFO - Using env: {'DISPLAY': ':0', 12:49:40 INFO - 'HOME': '/home/cltbld', 12:49:40 INFO - 'LANG': 'en_US.UTF-8', 12:49:40 INFO - 'LANGUAGE': 'en_US:en', 12:49:40 INFO - 'LOGNAME': 'cltbld', 12:49:40 INFO - 'MAIL': '/var/mail/cltbld', 12:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:40 INFO - 'MOZ_NO_REMOTE': '1', 12:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:40 INFO - 'NO_EM_RESTART': '1', 12:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:40 INFO - 'PWD': '/builds/slave/test', 12:49:40 INFO - 'SHELL': '/bin/bash', 12:49:40 INFO - 'SHLVL': '1', 12:49:40 INFO - 'TERM': 'linux', 12:49:40 INFO - 'TMOUT': '86400', 12:49:40 INFO - 'USER': 'cltbld', 12:49:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:40 INFO - '_': '/tools/buildbot/bin/python'} 12:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:49:41 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 12:49:41 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 12:49:41 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 12:49:41 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 12:49:41 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 12:49:41 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 12:49:43 INFO - Downloading blobuploader-1.2.4.tar.gz 12:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:49:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:49:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 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 12:49:43 INFO - Downloading docopt-0.6.1.tar.gz 12:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:49:43 INFO - Installing collected packages: blobuploader, requests, docopt 12:49:43 INFO - Running setup.py install for blobuploader 12:49:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:49:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:49:43 INFO - Running setup.py install for requests 12:49:44 INFO - Running setup.py install for docopt 12:49:44 INFO - Successfully installed blobuploader requests docopt 12:49:44 INFO - Cleaning up... 12:49:44 INFO - Return code: 0 12:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:49:44 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')]} 12:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:44 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')]} 12:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:44 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:44 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 12:49:44 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 12:49:44 INFO - Using env: {'DISPLAY': ':0', 12:49:44 INFO - 'HOME': '/home/cltbld', 12:49:44 INFO - 'LANG': 'en_US.UTF-8', 12:49:44 INFO - 'LANGUAGE': 'en_US:en', 12:49:44 INFO - 'LOGNAME': 'cltbld', 12:49:44 INFO - 'MAIL': '/var/mail/cltbld', 12:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:44 INFO - 'MOZ_NO_REMOTE': '1', 12:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:44 INFO - 'NO_EM_RESTART': '1', 12:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:44 INFO - 'PWD': '/builds/slave/test', 12:49:44 INFO - 'SHELL': '/bin/bash', 12:49:44 INFO - 'SHLVL': '1', 12:49:44 INFO - 'TERM': 'linux', 12:49:44 INFO - 'TMOUT': '86400', 12:49:44 INFO - 'USER': 'cltbld', 12:49:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:44 INFO - '_': '/tools/buildbot/bin/python'} 12:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:49:44 INFO - Running setup.py (path:/tmp/pip-Ue1hlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:49:44 INFO - Running setup.py (path:/tmp/pip-FWh_Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:49:44 INFO - Running setup.py (path:/tmp/pip-2Ny5ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:49:44 INFO - Running setup.py (path:/tmp/pip-uUTguf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:49:44 INFO - Running setup.py (path:/tmp/pip-DmXQyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:49:45 INFO - Running setup.py (path:/tmp/pip-3OWh2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:49:45 INFO - Running setup.py (path:/tmp/pip-cpQ4_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:49:45 INFO - Running setup.py (path:/tmp/pip-dUMvoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:49:45 INFO - Running setup.py (path:/tmp/pip-sqCJRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:49:45 INFO - Running setup.py (path:/tmp/pip-4zDl_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:49:45 INFO - Running setup.py (path:/tmp/pip-DQFKtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:49:45 INFO - Running setup.py (path:/tmp/pip-fvnYql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:49:45 INFO - Running setup.py (path:/tmp/pip-fHOaAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:49:45 INFO - Running setup.py (path:/tmp/pip-nY1dRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:45 INFO - Running setup.py (path:/tmp/pip-2w1O02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:49:45 INFO - Running setup.py (path:/tmp/pip-rKzJTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:49:45 INFO - Running setup.py (path:/tmp/pip-HES0fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:49:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:49:45 INFO - Running setup.py install for manifestparser 12:49:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Running setup.py install for mozcrash 12:49:46 INFO - Running setup.py install for mozdebug 12:49:46 INFO - Running setup.py install for mozdevice 12:49:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Running setup.py install for mozfile 12:49:46 INFO - Running setup.py install for mozhttpd 12:49:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Running setup.py install for mozinfo 12:49:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Running setup.py install for mozInstall 12:49:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Running setup.py install for mozleak 12:49:46 INFO - Running setup.py install for mozlog 12:49:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:49:46 INFO - Running setup.py install for moznetwork 12:49:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:49:47 INFO - Running setup.py install for mozprocess 12:49:47 INFO - Running setup.py install for mozprofile 12:49:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:49:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:49:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:49:47 INFO - Running setup.py install for mozrunner 12:49:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:49:47 INFO - Running setup.py install for mozscreenshot 12:49:47 INFO - Running setup.py install for moztest 12:49:47 INFO - Running setup.py install for mozversion 12:49:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:49:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:49:47 INFO - Cleaning up... 12:49:47 INFO - Return code: 0 12:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:49: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')]} 12:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:47 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:47 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 12:49:47 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 12:49:47 INFO - Using env: {'DISPLAY': ':0', 12:49:47 INFO - 'HOME': '/home/cltbld', 12:49:47 INFO - 'LANG': 'en_US.UTF-8', 12:49:47 INFO - 'LANGUAGE': 'en_US:en', 12:49:47 INFO - 'LOGNAME': 'cltbld', 12:49:47 INFO - 'MAIL': '/var/mail/cltbld', 12:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:47 INFO - 'MOZ_NO_REMOTE': '1', 12:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:47 INFO - 'NO_EM_RESTART': '1', 12:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:47 INFO - 'PWD': '/builds/slave/test', 12:49:47 INFO - 'SHELL': '/bin/bash', 12:49:47 INFO - 'SHLVL': '1', 12:49:47 INFO - 'TERM': 'linux', 12:49:47 INFO - 'TMOUT': '86400', 12:49:47 INFO - 'USER': 'cltbld', 12:49:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:47 INFO - '_': '/tools/buildbot/bin/python'} 12:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:49:47 INFO - Running setup.py (path:/tmp/pip-igNNLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:49:48 INFO - Running setup.py (path:/tmp/pip-nqFe53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:49:48 INFO - Running setup.py (path:/tmp/pip-_xxXtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:49:48 INFO - Running setup.py (path:/tmp/pip-tyxwXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:49:48 INFO - Running setup.py (path:/tmp/pip-tDaBCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:49:48 INFO - Running setup.py (path:/tmp/pip-96DCDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:49:48 INFO - Running setup.py (path:/tmp/pip-10KWGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:49:48 INFO - Running setup.py (path:/tmp/pip-Gbzd74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:49:48 INFO - Running setup.py (path:/tmp/pip-jYWAjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:49:48 INFO - Running setup.py (path:/tmp/pip-kxzCUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:49:48 INFO - Running setup.py (path:/tmp/pip-CjtVBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:49:48 INFO - Running setup.py (path:/tmp/pip-jdtK4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:49:48 INFO - Running setup.py (path:/tmp/pip-9u2Jx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:49:48 INFO - Running setup.py (path:/tmp/pip-SIMkZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:49:48 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)) 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:48 INFO - Running setup.py (path:/tmp/pip-hHKW0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:49 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)) 12:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:49:49 INFO - Running setup.py (path:/tmp/pip-kSWZEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:49:49 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)) 12:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:49:49 INFO - Running setup.py (path:/tmp/pip-5t4Q5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:49:49 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)) 12:49:49 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)) 12:49:49 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)) 12:49:49 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)) 12:49:49 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)) 12:49:49 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)) 12:49:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:49:49 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 12:49:49 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 12:49:49 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 12:49:49 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 12:49:49 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 12:49:49 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 12:49:51 INFO - Downloading blessings-1.6.tar.gz 12:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:49:51 INFO - Installing collected packages: blessings 12:49:51 INFO - Running setup.py install for blessings 12:49:51 INFO - Successfully installed blessings 12:49:51 INFO - Cleaning up... 12:49:51 INFO - Return code: 0 12:49:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:49:51 INFO - Reading from file tmpfile_stdout 12:49:51 INFO - Current package versions: 12:49:51 INFO - argparse == 1.2.1 12:49:51 INFO - blessings == 1.6 12:49:51 INFO - blobuploader == 1.2.4 12:49:51 INFO - docopt == 0.6.1 12:49:51 INFO - functools32 == 3.2.3-2 12:49:51 INFO - jsonschema == 2.5.1 12:49:51 INFO - manifestparser == 1.1 12:49:51 INFO - mozInstall == 1.12 12:49:51 INFO - mozcrash == 0.17 12:49:51 INFO - mozdebug == 0.1 12:49:51 INFO - mozdevice == 0.48 12:49:51 INFO - mozfile == 1.2 12:49:51 INFO - mozhttpd == 0.7 12:49:51 INFO - mozinfo == 0.9 12:49:51 INFO - mozleak == 0.1 12:49:51 INFO - mozlog == 3.4 12:49:51 INFO - moznetwork == 0.27 12:49:51 INFO - mozprocess == 0.23 12:49:51 INFO - mozprofile == 0.28 12:49:51 INFO - mozrunner == 6.12 12:49:51 INFO - mozscreenshot == 0.1 12:49:51 INFO - mozsystemmonitor == 0.3 12:49:51 INFO - moztest == 0.7 12:49:51 INFO - mozversion == 1.4 12:49:51 INFO - psutil == 3.1.1 12:49:51 INFO - requests == 1.2.3 12:49:51 INFO - wsgiref == 0.1.2 12:49:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:49:51 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')]} 12:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:51 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')]} 12:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:51 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:51 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 12:49:51 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 12:49:51 INFO - Using env: {'DISPLAY': ':0', 12:49:51 INFO - 'HOME': '/home/cltbld', 12:49:51 INFO - 'LANG': 'en_US.UTF-8', 12:49:51 INFO - 'LANGUAGE': 'en_US:en', 12:49:51 INFO - 'LOGNAME': 'cltbld', 12:49:51 INFO - 'MAIL': '/var/mail/cltbld', 12:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:51 INFO - 'MOZ_NO_REMOTE': '1', 12:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:51 INFO - 'NO_EM_RESTART': '1', 12:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:51 INFO - 'PWD': '/builds/slave/test', 12:49:51 INFO - 'SHELL': '/bin/bash', 12:49:51 INFO - 'SHLVL': '1', 12:49:51 INFO - 'TERM': 'linux', 12:49:51 INFO - 'TMOUT': '86400', 12:49:51 INFO - 'USER': 'cltbld', 12:49:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:51 INFO - '_': '/tools/buildbot/bin/python'} 12:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 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)) 12:49:51 INFO - Cleaning up... 12:49:51 INFO - Return code: 0 12:49:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:49:51 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')]} 12:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:51 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')]} 12:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:51 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 0x7fa270c9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', '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 12:49:51 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 12:49:51 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 12:49:51 INFO - Using env: {'DISPLAY': ':0', 12:49:51 INFO - 'HOME': '/home/cltbld', 12:49:51 INFO - 'LANG': 'en_US.UTF-8', 12:49:51 INFO - 'LANGUAGE': 'en_US:en', 12:49:51 INFO - 'LOGNAME': 'cltbld', 12:49:51 INFO - 'MAIL': '/var/mail/cltbld', 12:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:51 INFO - 'MOZ_NO_REMOTE': '1', 12:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:51 INFO - 'NO_EM_RESTART': '1', 12:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:51 INFO - 'PWD': '/builds/slave/test', 12:49:51 INFO - 'SHELL': '/bin/bash', 12:49:51 INFO - 'SHLVL': '1', 12:49:51 INFO - 'TERM': 'linux', 12:49:51 INFO - 'TMOUT': '86400', 12:49:51 INFO - 'USER': 'cltbld', 12:49:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:51 INFO - '_': '/tools/buildbot/bin/python'} 12:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:49:51 INFO - Cleaning up... 12:49:52 INFO - Return code: 0 12:49:52 INFO - Running post-action listener: _resource_record_post_action 12:49:52 INFO - Running post-action listener: _start_resource_monitoring 12:49:52 INFO - Starting resource monitoring. 12:49:52 INFO - [mozharness: 2016-10-03 19:49:52.045659Z] Finished create-virtualenv step (success) 12:49:52 INFO - [mozharness: 2016-10-03 19:49:52.046587Z] Running install step. 12:49:52 INFO - Running pre-action listener: _resource_record_pre_action 12:49:52 INFO - Running main action method: install 12:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:49:52 INFO - Reading from file tmpfile_stdout 12:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:49:52 INFO - Reading from file tmpfile_stdout 12:49:52 INFO - Output received: 12:49:52 INFO - Usage: mozinstall [options] installer 12:49:52 INFO - Options: 12:49:52 INFO - -h, --help show this help message and exit 12:49:52 INFO - -d DEST, --destination=DEST 12:49:52 INFO - Directory to install application into. [default: 12:49:52 INFO - "/builds/slave/test"] 12:49:52 INFO - --app=APP Application being installed. [default: firefox] 12:49:52 INFO - mkdir: /builds/slave/test/build/application 12:49:52 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'] 12:49:52 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 12:50:08 INFO - Reading from file tmpfile_stdout 12:50:08 INFO - Output received: 12:50:08 INFO - /builds/slave/test/build/application/firefox/firefox 12:50:08 INFO - Running post-action listener: _resource_record_post_action 12:50:08 INFO - [mozharness: 2016-10-03 19:50:08.474594Z] Finished install step (success) 12:50:08 INFO - [mozharness: 2016-10-03 19:50:08.474841Z] Running run-tests step. 12:50:08 INFO - Running pre-action listener: _resource_record_pre_action 12:50:08 INFO - Running main action method: run_tests 12:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:50:08 INFO - Python 2.7.3 12:50:08 INFO - Return code: 0 12:50:08 INFO - grabbing minidump binary from tooltool 12:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:08 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 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:50:08 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 12:50:08 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 12:50:08 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 12:50:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:50:08 INFO - Return code: 0 12:50:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:50:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:50:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:50:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:50:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 12:50:08 INFO - Using env: {'DISPLAY': ':0', 12:50:08 INFO - 'HOME': '/home/cltbld', 12:50:08 INFO - 'LANG': 'en_US.UTF-8', 12:50:08 INFO - 'LANGUAGE': 'en_US:en', 12:50:08 INFO - 'LOGNAME': 'cltbld', 12:50:08 INFO - 'MAIL': '/var/mail/cltbld', 12:50:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:50:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:08 INFO - 'MOZ_NO_REMOTE': '1', 12:50:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:08 INFO - 'NO_EM_RESTART': '1', 12:50:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:08 INFO - 'PWD': '/builds/slave/test', 12:50:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:50:08 INFO - 'SHELL': '/bin/bash', 12:50:08 INFO - 'SHLVL': '1', 12:50:08 INFO - 'TERM': 'linux', 12:50:08 INFO - 'TMOUT': '86400', 12:50:08 INFO - 'USER': 'cltbld', 12:50:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640', 12:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:08 INFO - '_': '/tools/buildbot/bin/python'} 12:50:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:50:08 INFO - mozversion application_buildid: 20161003115257 12:50:08 INFO - mozversion application_changeset: 27f488a1f9efa704afc98f2319aca94eaed4b32d 12:50:08 INFO - mozversion application_display_name: Nightly 12:50:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:50:08 INFO - mozversion application_name: Firefox 12:50:08 INFO - mozversion application_remotingname: firefox 12:50:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:50:08 INFO - mozversion application_vendor: Mozilla 12:50:08 INFO - mozversion application_version: 52.0a1 12:50:08 INFO - mozversion platform_buildid: 20161003115257 12:50:08 INFO - mozversion platform_changeset: 27f488a1f9efa704afc98f2319aca94eaed4b32d 12:50:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:50:08 INFO - mozversion platform_version: 52.0a1 12:50:08 INFO - using testdate: 1475524208 12:50:08 INFO - actual date: 1475524208 12:50:08 INFO - starting webserver on 'localhost:57484' 12:50:08 INFO - SUITE-START | Running 2 tests 12:50:08 INFO - TEST-START | dromaeo_css 12:50:08 INFO - operating with platform_type : linux_ 12:50:08 INFO - Initialising browser for dromaeo_css test... 12:50:08 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDMUivb/profile http://localhost:57484/getInfo.html) 12:50:15 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 12:50:15 INFO - PROCESS | 3340 | colorDepth:24 12:50:15 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 12:50:15 INFO - PROCESS | 3340 | __metrics 12:50:15 INFO - PROCESS | 3340 | 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" 12:50:15 INFO - PROCESS | 3340 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:50:16 INFO - PROCESS | 3340 | console.error: PushService: 12:50:16 INFO - PROCESS | 3340 | stateChangeProcessEnqueue: Error transitioning state 12:50:16 INFO - PROCESS | 3340 | UnknownError 12:50:16 INFO - TEST-INFO | 3340: exit 0 12:50:16 INFO - Browser initialized. 12:50:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:50:16 INFO - TEST-INFO | started process 3422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDMUivb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:29 INFO - PROCESS | 3422 | RSS: Main: 175677440 12:50:29 INFO - PROCESS | 3422 | 12:51:20 INFO - PROCESS | 3422 | 1475524280546 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] 12:53:34 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:57484/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57484/tests/dromaeo/cssquery-ext.html) 12:53:35 INFO - PROCESS | 3422 | RSS: Main: 267653120 12:53:35 INFO - PROCESS | 3422 | 12:56:38 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:57484/tests/dromaeo/cssquery-ext.html (next: http://localhost:57484/tests/dromaeo/cssquery-jquery.html) 12:56:38 INFO - PROCESS | 3422 | RSS: Main: 283201536 12:56:38 INFO - PROCESS | 3422 | 12:59:40 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:57484/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57484/tests/dromaeo/cssquery-mootools.html) 12:59:41 INFO - PROCESS | 3422 | RSS: Main: 218820608 12:59:41 INFO - PROCESS | 3422 | 13:02:43 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:57484/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57484/tests/dromaeo/cssquery-prototype.html) 13:02:44 INFO - PROCESS | 3422 | RSS: Main: 258961408 13:02:44 INFO - PROCESS | 3422 | 13:05:47 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:57484/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57484/tests/dromaeo/cssquery-yui.html) 13:05:48 INFO - PROCESS | 3422 | RSS: Main: 220028928 13:05:48 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:57484/tests/dromaeo/cssquery-yui.html (next: http://localhost:57484/tests/dromaeo/cssquery-dojo.html) 13:08:51 INFO - PROCESS | 3422 | RSS: Main: 289263616 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | __start_tp_report 13:08:51 INFO - PROCESS | 3422 | _x_x_mozilla_page_load 13:08:51 INFO - PROCESS | 3422 | _x_x_mozilla_page_load_details 13:08:51 INFO - PROCESS | 3422 | |i|pagename|runs| 13:08:51 INFO - PROCESS | 3422 | |0;dojo.html;2573.4595734895674;2605.5961325994454;2629.6187052877335;2635.6046593011047;2651.668541432321;4495.033567782926;4590.609798167152;4631.027484228312;4652.325412815144;4663.510331415199;4592.3341115538315;4594.885127871797;4610.077984403116;4616.953830461694;4620.029793743318;4195.790210489478;4212.7682977436225;4221.535631080578;4252.829886804524;4284.571542845706;4284.357346398034;4287.078278170193;4292.59220374064;4335.176316499855;4353.477582690081;4283.37891005804;4305.870823875289;4323.5460276670965;4325.243082460573;4382.627476664487;4360.215161270954;4378.277584198603;4388.407564978751;4404.471463424377;4407.669424793121;4139;4272.594103560157;4282.464691913511;4327.740335579844;4337.980574564975;4536.56902594253;4543.31850222466;4610.561996610317;4648.953510464886;4679.789409476548;4816.710997340171;4821.0357928414105;4821.108095002436;4838.032393521275;4937.358143441365;4856.198727210041;4907.4356449008465;4912.115819152551;4920.360353154103;4971.378577677754;4494.955050449454;4554.908901822011;4572.3827283317;4574;4707.976460117678;5069.417017043013;5090.109230884655;5090.2364645303505;5094.2103973884105;5143.074246635641;4871.585915197248;4891.144049791273;4898.289747986522;4902.460729319772;4928.162212423897;4778.235482322812;4778.307145463888;4829.034193161382;4829.203181475017;5002.074616195942;4775.21209000511;4778.665493415497;4782.258749893772;4824.831130910471;4837.419509658793;4739.3601863748645;4759.785809638574;4762.476127625959;4769.856904292877;4849.248366503198;3994.6005399459823;4023.1350259693722;4027.134166154291;4062.7608579383573;4072.063425412172;3570.589382221026;3613.259281847215;3629.2197177606413;3706.5366829146355;3732.682721968663;4339.7396156230725;4345.587169218919;4347.282698354799;4348.543402942709;4405.977970110129;4920.852374428773;4946.579540739078;4951.851444456672;4977.278294647256;5006.073876332817;4170.937435938464;4230.302000169999;4322.589354011364;4366.563343665672;4368.235558777201;4472.1502914446155;4490.259107247268;4494.617957473652;4539.523350048197;4551.499335073139;4729.361536192639;4738.691985020962;4744.739039352799;4745.908441058645;4796.9280460792415;4693.061387722538;4809.350737650372;4878.07316609843;4890.926636100533;4958.380202474691;4683.976580117078;4690.484046754923;4724.149653062482;4731.668783185144;4734;4885.755712214446;4889.364382630235;4891.26631005352;4893.90212195747;4944.777485013111;4770.379850619397;4813.470518243061;4912.8771780705765;4957.97521012407;5001.599872010303;4853.757312134449;4881.121398148225;4887.731174785279;4937.604991600735;4947.727874966911;4878.365812444502;4882.511748825089;4882.902341953212;4888.633352498506;4950.430700469348;4593.28804035375;4644.558766917137;4798.160321943716;4807.903841923212;4859.902801943871;4824.372831532019;4841.443234028132;4872.244802055687;4889.853304400874;4949.257611358325;4739.881502962454;4764.190087685171;4780.378550788375;4829.179039563212;4841.394825646794 13:08:51 INFO - PROCESS | 3422 | |1;ext.html;547.7206624621443;559.6642014791125;571.3714913595044;582.7960213925126;584.4681339980618;27711.584326235097;38502.80748596256;39754;39817.40273895887;43360.783196083976;39812.60187398125;39939.20121597566;40197.39703904444;40240;40287.19425611486;7682.347000504949;7832.490888092284;7832.686692532292;7836.80407989802;7837.647305871249;7231.421486281111;7413.925860741405;9876.35803672759;10131.290809643328;10131.89868101317;10088.798224035514;10199.898001019968;10205.43870087145;10206.64276750314;10208.591656333738;10050.346727462727;10120.848187277197;10126.949365253164;10128.94935525325;10133.493325333704;9830.361026533252;9899.109080182747;9900.455474948874;9902.356346837432;9907.108360247612;38101.61898381008;38111;38118;38137.237255255015;38141.80929095364;2904.7966642335045;3027.455058089543;3051.6948305169526;3116.98441507791;3372.544706464645;28200.76988451728;28576.571351429746;28640.71359286422;28864.567031494546;29273.56089658657;3476.28736109097;3557.0929412999776;3572.6427357264324;3585.515955346021;3686.6129056448954;250616;252051;252378;252520;252863;31568.684313157035;32757.344853102804;51747;52165;52191.73904130455;33495.162620934185;33784.32431351359;33811.66188338085;33813.49279760806;33830;11927.403629818475;12022.098342624338;12033.217840840492;12033.939830300793;12034;8678.522681252593;8923.821523569492;9590.856137157949;9653.1794797443;9662.468564228895;7639.541627502367;7899.526028438312;7950.1254861965135;7998.360131189491;8019;3077.3994426521026;3151.306712523241;3154.069549482908;3155.542446345267;3192;788.5111231036794;799.7360870912585;956.3806813092746;968.2931460034215;1018.0532105142289;27261;28927.42145157085;30242;31722.68277317197;32189.389253576337;907.2016625369632;928.661038720862;959.7984423271191;962.8892677342055;1024.5850430575629;13979.79030314546;14033;14113.294335283195;14297.213653248964;14361.928190358982;177934;178077;178725;179618.1019094896;179714;47572;47992.28011579829;48052.5194748055;48080.27879581809;48096.7595162022;1058.9894101059044;1117.9664610061548;1118.692359601116;1165.2542372881362;1168.6143572621015;26659.20022399331;28383.574246386735;29435.558466623446;30632;30682.232944176576;46966.76516617395;47771.761141195464;47816;47848;47877;340221;341754;341772;343728;344328;24976.75302210701;25127.74872251327;25389.11138110157;26066.218013459627;26163;40407.1918561633;41064.384034238916;41942.16115677731;42031.7898410506;42133.57866421297;35173.47239791354;35310.29379412449;35493.29013419769;35821.82089089538;36095.81952090223;35498.467522987696;35926.233296394035;35954.8202258987;36239.275214495035;36577.45133822942;34381;34894;34997.82501087478;35257.82371088231;35909.64090359063;30546.694533054386;32751;32829.34341313208;32936.505952410254;33098.5035224467;25378;26769.464610708066;27043.72956270412;27137.457250855266;27240.591391128753 13:08:51 INFO - PROCESS | 3422 | |2;jquery.html;334.4181124842771;346.09841363248734;361.345963805512;364.10975165719816;387.05558437412714;12019.879801201996;15508.371620979804;16009.27958241879;17406.912965435156;17450.040247786368;14518.637034074154;15926.442574509894;16403.83596164038;16840.57898552534;16927.153642317895;4291.570842915699;4736.455307639631;4984.551390374856;5151.562117220041;5232.555232805216;5072.771725272371;5153.201253805666;5161.251618515313;5163.561097306733;5172.301739265207;4930.482299358569;5045.571126454256;5123;5143.151380022292;5147.691138531682;5059.013492368989;5106.897862042775;5116.155834287357;5117.872053198663;5119.846404607868;4396.89007774805;4428.202923473774;4441.333799930037;4608;4617.861464156081;19422.47507823974;19583.608327833364;20377.796222037738;20487.5902481951;20656.690149647766;1901.7717873855088;2140.796624320687;2159.838012149095;2292.5414917016665;2345.1323010486058;11835.963271805509;12346.75306493874;13122.803157952638;13185.34073296341;13811.585652430444;1687.8987260764393;1690.8985460872264;1690.9661806763918;1709.1625103699223;1718;64867.351326486605;65213;65620.67189664069;66322;66696.6665166676;9516.762080947894;9581.712548623553;9827.361221520578;9850.852237216448;9930.702078937644;13333.799993000113;13344.06591538583;13350.265735384453;13402.195868247936;13417.262050587116;6262.1859158310035;6669.666516674147;6681.064650948871;6688.899666505006;6876.724931002804;6205.968970155121;6258.15514905491;6415.935840641534;6418.679066046679;6474.223093228843;4145.8963525912095;4162.791860406967;4164.9583504165175;4171.374293855885;4230.576942305806;1667.8665706743432;1764.0914928811671;1779.6796576616334;1789.1322708486373;1800.8649351298704;649.4869053447818;804.6419343392251;812.7196117339508;844.3751623798345;849.163573879728;16068.35726570924;16250.512484625244;16434.506964791075;16465.67068658644;17111.22999465027;816.1348970091722;818.145038434837;834.4284165346756;837.1753822484848;910.9863352049724;9184.632614695338;9214.124658157465;9635;9689.660861869801;9890.456024918554;129532;129540.35229823978;129773;373924.1303793464;377199;71021.27829136142;72527.28572642761;73044.26955730375;74863.62568187124;75023.62488187633;889.7241855024963;904.8733177355175;909.8817153769968;924.7364501117149;928.4707716601472;14195;14319.713605727618;14339.569812905629;14931.253437328307;15389.615259618598;35108;35251.82374088113;35532;35891.461628076126;36041.279174416886;46931;47252;47401.28898066463;47828;49829.25256121089;4816.181249187576;7737.458377913492;7801.882971755542;7901.723439679814;8032.919670803451;10911.945440272748;11893.82159267629;12035.398230088285;12062.638120856389;12178.634640960785;9925.65260215889;10039.498025098861;10382.740431489274;10386.428746418716;11029.22795404314;9808.313418060667;9993.450360230258;10054.54754536033;10082.092611664986;10097.747556311151;9888.208943284664;10016.1987041038;10264.846027309746;10274.126699230648;10471;7860.449768516149;7941;8057.355411567178;8135.267825895698;8183.590820459072;8918.777030574287;10431.739206519898;10473.9476302618;10740.624078157227;10875.673729788119 13:08:51 INFO - PROCESS | 3422 | |3;mootools.html;1352.7294541091785;1360.3742278551865;1433.7634290342094;1621.5378617094123;1647.5798671338807;6287.811365659026;6563.967180164104;6928.203256625489;7455.4781165318445;7462;7068.823279418017;7344.522606030604;7371.63141842907;7541.208173141809;7561.395088392929;2067.524469372045;2089.1747759634936;2104.4002459299104;2106.547092375139;2108.7153234313323;1729.4638662014752;2075.875467195253;2116.883571403572;2124.915003399862;2126.9468263293465;1704.940327088552;2042.6323261812868;2110.862793918398;2117.216629846951;2137.177186783092;2054.897255137237;2055.1368425261353;2058.559008693905;2067.8759274443582;2069.803368679973;2045.7545094588745;2046.0997161249002;2047.8668886522328;2050.5796311756053;2056.20835978148;7460.104787425489;7473.290037446434;7493.100827900686;7525;7530.209328020534;4169.353750168699;4303.612674859246;4339.7830108494445;4389.144116897206;4404.1852257332175;2566.4995325911455;2721.496523143205;2730.331068888115;2735.9042433514733;2741.9588706169425;807.757672698194;841.0790184747691;855.1234984141242;857.7769779857219;885.7342797160826;9601.951990240073;9633.903660963371;9660.323777335589;9666.951665241699;9667.323287369958;3612.710983121344;3642.1805093853673;3703.9074023149637;3796.981015094962;3809.3904975203836;7879;7888.64501097452;7889.960550197212;7902.841943161219;7902.960485197537;4267.061246525759;4273.337632666941;4278.4010238566625;4279.614834664895;4281.892952676208;3971.5035620547433;3991.900202494961;3995.4406383105807;3996.800159991989;4001.239764444746;3133.5613014178034;3227.1609381560493;3264.4450443424676;3295.110320213577;3335.116194208537;888.5868071346855;978.9021097890296;979.5151400057017;982.2387649571639;1002.6089824968268;689.8344397344702;785.6346798738614;803.6785285885693;812.4597142900024;820.8713019598052;4817.159633320693;4926.285688575136;4998.2502624606595;5010.774515146827;5022.547970682656;806.4516129032197;807.3420162567606;825.5954582254652;864.0711235421946;885.154677283193;3299.802011879295;3431.433813420758;3440;3472.392331342005;3617.5478065241846;8578.742637720878;9013.819723605491;9017.458952462874;9026.684066057656;9037.683681071263;8438.36712246584;8849.778755531162;8911.598978046004;8911.955440222757;8928.330375221884;6768.424683901923;6944.2708515607155;6948.305169483112;6951.721931122698;6956.617386043715;5027.949720502748;5128.564072053917;5161.8451446455165;5213.478652134756;5310.283111780015;8018.3184429324165;8071.394645401736;8214.26071653554;8297.08732039463;8374.706885259231;8180.754577362689;8315.667373305241;8388.119247479171;8480.024797148408;8506.574671266535;6292.087647291209;6405.551611387158;6441;6441.420272175526;6492.156019717596;6978.47661425385;7099.787006389816;7111.395531379891;7111.573305601681;7120.928790712027;6130.448259656652;6270.655113968775;6310.873782524232;6415.06981487691;6519.750686013318;6281.654509002049;6305.558610897377;6319.399657032574;6319.936800631935;6341.334159913143;5795.24661793981;5897.5281977440845;5930.436608522184;5931.7627294907725;5936.970315148569;4355.346697995326;4391.736495810262;4409.64722822167;4455.7994890229365;4580.0610874771255;4027.899302517343;4389.868303950887;4452.287633978548;4482.887927801831;4494.910101798011 13:08:51 INFO - PROCESS | 3422 | |4;prototype.html;285.3593682183498;293.87657183982714;298.55366227489907;301.8762307453944;306.6718611086139;4812.566868981791;4869.293952376903;4870.293807397925;4871.658983871131;4890.779914903829;4512.255477846152;4602.884927876797;4669;4733.621310295177;4811.542903424178;3781.149241420686;3788.2802267569214;3788.299164654534;3792.2745150956384;3796.1648437343742;3753.51204343435;3755.530558680165;3775.8300876460626;3777.452269420932;3805.885823425288;3486.1284678830293;3601.963980360202;3668.816559172031;3761.9435708464257;3771.9061472173175;3716.312482190803;3722.925541489155;3763.9811800941093;3764.0778009387736;3773.8867833964887;3315.4860996545576;3316.6849149330774;3326.8835590754206;3329.317489914586;3342.916427089318;4459.241928872099;4651.209294419923;4679.64902632304;4680.946786972938;4685.367475390813;4211.789410529492;4222.577742225783;4231.566849061771;4238.4490016298;4240.724352917081;5020.573251273646;5021.920287138283;5026.346574945233;5028.547430731252;5038.748062596892;3528.947065794015;3535.656450548801;3538.9115272118147;3542.256126213498;3546.1666508370513;4950.133726597867;5186.559142472895;5198.376194856603;5199.974000130013;5202;3608.6210947850623;3627.3470775260707;3632.4914511968345;3639.8726044588843;3644.5444319460066;3673.8530458781884;3679.7121007647643;3684.3920753075977;3686.465462507975;3691.8892433227047;3960.5643379228836;4187.973946383156;4194.762545049218;4204.3693445983345;4213.136307057046;4998.2002879539095;5015.4733752956145;5029.622778291569;5031.77357018935;5034.677113105333;1267.9429425675867;1284.4990453723055;1285.2160182288796;1288.2978776566792;1289.232906420678;777.1257335497565;790.1190172957112;840.844443777903;878.1394233651058;879.8152387998464;4474.39595654589;4481.551844815493;4487.6634252431195;4493.775311234491;4501.144782491317;5114.181730923035;5124.410692770304;5129.79480820763;5140.845774626767;5162.6386152968935;4353.586409291112;4420;4445.555444455528;4467.508574056851;4484.932726009112;2712.362594790223;2725.514594545977;2728.727127287295;2732.2486316263185;2732.904348347838;4850.805967761321;4854.951450485521;4866.7079975200895;4906.632002599819;4907.5828554572545;4984.800607975641;5175.818846340435;5182.689038657617;5186.40356359016;5217.50433708797;4883.973151142236;4912.70523768575;4917.188663870421;4922.138625740481;4928.6303527235605;5143.948560514496;5148.279240906201;5150.381954165524;5150.48495150482;5166.3800343958965;4882.776398415416;4956.900861982668;4995.226694523391;5013.39839219296;5037.571806396498;4872.465173470346;4877.365942427604;4879.292502587176;4892.339534162985;4911.263310503453;3648.416253399443;3657.085728567858;3660.2496488220386;3661.0664280608275;3676.28312479064;5018.84943451697;5091.287219789307;5119.92320115206;5147.6654017488745;5158.3294171758935;4920.31115643803;4944.283078953604;4948.925766113439;4958.181899986462;4974;4953.993632578811;4957.463186412224;4985.5762260208285;5019.272205530105;5035.899282014266;4638.234691276037;4862.41651001882;4910.607151427806;4916.8770780730765;4926.704397736147;4788.928166077581;4903.6077113831525;4930.975345123252;4995.575376093073;5069.493050694901;4940.777665005012;4948.925766113583;4969.453360130455;4980.825671101494;4981.875453113701 13:08:51 INFO - PROCESS | 3422 | |5;yui.html;579.111064515968;620.4199073865935;645.5965021861334;646.4117652935828;652.1522021372215;11577.594784182555;12007.759844803099;12325.383730813468;12376.13367064306;12957.74084518309;12414.937925310383;12603.432845521951;12609.054320925921;12648.114631975743;12657;620.6834514397667;732.9157146928118;751.3801114080878;753.4462170304821;753.8605358008786;627.6202897247168;759.9012128423298;777.141258908906;783.1463704562026;785.0265670568483;816.1512027491402;817.3542901108148;819.3731795176694;820.6840366458897;822.2558584481054;648.1088503307951;802.1577343788998;803.3051410529879;803.445622520459;804.1837534902049;492.57392355612495;575.3728436004775;592.1000079878561;597.8206538038571;599.3437186281016;11052.668419947415;11105.167112466517;11144.219904606682;11154.832677509843;11161.553537858475;11567.652970410816;12006.819897701542;12075.154739168262;12338.259704417675;12689.111762176652;11229.3262404256;11284.32294062359;11507.827382589268;11516.827247591293;11607;4058.8782336529953;4167.1457351242925;4225.852095176654;4248.4052232687445;4400.603945644907;44109.33835992463;44351.77824110859;48725.26912096321;59427.40572594305;59532.40467595312;9904.653337133166;9976.900230997742;10133.18934485254;10272.075513203847;10454.42500662471;18310.81689183118;18341.54146146357;18345.633087338447;18345.908270458563;18363.54091147732;6317.747290108436;6332.873342533124;6399.104125422445;6610.206775187008;6690.364415380531;3542.2915416916203;3590.1024743814046;3603.1532589841368;3645.8906232813056;3650.1969566695284;2572.3954870605394;2652.562327215988;2656.0969270447754;2656.5085459190113;2661.055325359508;445.1408781052535;455.4511813265008;458.61476359857215;461.7621924708778;463.3212343916179;465.21611085320666;511.2765436906735;515.3841159814061;516.7855340033843;518.3572370260924;7041;7233.1681856587165;7334.523255988343;7398.593077380688;7421.443391745641;410.4950910380249;413.84687665563933;429.3666841408897;490.1838438999098;494.05142127115306;3438.8796392126155;3503.9474407883904;3579.534660494119;3583.605803361628;3705.5299057181746;95707;96335;98716.53208669841;100935;101782;29270.414591708046;29403.852980735388;29824.701752982193;68070;84276;72734.2726572738;74858.62570687111;74946.62526687332;78739.60630196812;79647.60176199197;6666.033425153229;6698.799036028927;6805.319468053155;6826.214985276757;6864.1762988439705;36073;36709.81645091758;36896.26207475782;40721;45986;54013.72993135009;57843.71078144582;58479.70760146172;59846.70076649589;62205;9579.329446938647;9839.044652128581;10251.794964100527;10324.896751032393;10410.219233557362;10935.343879367263;11352.943235284101;11353.572584862768;11374.976252137347;11742.58900938463;10483.423411712429;11618.419079046183;11800.379152564134;11908.702282443008;11911.404429778304;11241.71895702614;11754.471048802654;11844.940775296069;11864.347460889388;11870.703232419259;10665.41340226295;11428.428578571204;11529.1929564933;11897.524099035942;11929.28424294545;8487;9267.86098208514;9326.300527460604;9654.517274136406;9668.613255469983;9007.414518056305;9329.86005209936;9961.750956226153;10024.799504010025;10096.596136154472 13:08:51 INFO - PROCESS | 3422 | __end_tp_report 13:08:51 INFO - PROCESS | 3422 | __start_cc_report 13:08:51 INFO - PROCESS | 3422 | _x_x_mozilla_cycle_collect,958 13:08:51 INFO - PROCESS | 3422 | __end_cc_report 13:08:51 INFO - PROCESS | 3422 | __startTimestamp1475525331514__endTimestamp 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | ------- Summary: start ------- 13:08:51 INFO - PROCESS | 3422 | Number of tests: 6 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | [#0] dojo.html Cycles:165 Average:4570.72 Median:4731.67 stddev:466.67 (9.9%) stddev-sans-first:441.01 13:08:51 INFO - PROCESS | 3422 | Values: 2573.5 2605.6 2629.6 2635.6 2651.7 4495.0 4590.6 4631.0 4652.3 4663.5 4592.3 4594.9 4610.1 4617.0 4620.0 4195.8 4212.8 4221.5 4252.8 4284.6 4284.4 4287.1 4292.6 4335.2 4353.5 4283.4 4305.9 4323.5 4325.2 4382.6 4360.2 4378.3 4388.4 4404.5 4407.7 4139.0 4272.6 4282.5 4327.7 4338.0 4536.6 4543.3 4610.6 4649.0 4679.8 4816.7 4821.0 4821.1 4838.0 4937.4 4856.2 4907.4 4912.1 4920.4 4971.4 4495.0 4554.9 4572.4 4574.0 4708.0 5069.4 5090.1 5090.2 5094.2 5143.1 4871.6 4891.1 4898.3 4902.5 4928.2 4778.2 4778.3 4829.0 4829.2 5002.1 4775.2 4778.7 4782.3 4824.8 4837.4 4739.4 4759.8 4762.5 4769.9 4849.2 3994.6 4023.1 4027.1 4062.8 4072.1 3570.6 3613.3 3629.2 3706.5 3732.7 4339.7 4345.6 4347.3 4348.5 4406.0 4920.9 4946.6 4951.9 4977.3 5006.1 4170.9 4230.3 4322.6 4366.6 4368.2 4472.2 4490.3 4494.6 4539.5 4551.5 4729.4 4738.7 4744.7 4745.9 4796.9 4693.1 4809.4 4878.1 4890.9 4958.4 4684.0 4690.5 4724.1 4731.7 4734.0 4885.8 4889.4 4891.3 4893.9 4944.8 4770.4 4813.5 4912.9 4958.0 5001.6 4853.8 4881.1 4887.7 4937.6 4947.7 4878.4 4882.5 4882.9 4888.6 4950.4 4593.3 4644.6 4798.2 4807.9 4859.9 4824.4 4841.4 4872.2 4889.9 4949.3 4739.9 4764.2 4780.4 4829.2 4841.4 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | [#1] ext.html Cycles:180 Average:41313.69 Median:189054.50 stddev:69928.02 (37.0%) stddev-sans-first:70057.19 13:08:51 INFO - PROCESS | 3422 | Values: 547.7 559.7 571.4 582.8 584.5 27711.6 38502.8 39754.0 39817.4 43360.8 39812.6 39939.2 40197.4 40240.0 40287.2 7682.3 7832.5 7832.7 7836.8 7837.6 7231.4 7413.9 9876.4 10131.3 10131.9 10088.8 10199.9 10205.4 10206.6 10208.6 10050.3 10120.8 10126.9 10128.9 10133.5 9830.4 9899.1 9900.5 9902.4 9907.1 38101.6 38111.0 38118.0 38137.2 38141.8 2904.8 3027.5 3051.7 3117.0 3372.5 28200.8 28576.6 28640.7 28864.6 29273.6 3476.3 3557.1 3572.6 3585.5 3686.6 250616.0 252051.0 252378.0 252520.0 252863.0 31568.7 32757.3 51747.0 52165.0 52191.7 33495.2 33784.3 33811.7 33813.5 33830.0 11927.4 12022.1 12033.2 12033.9 12034.0 8678.5 8923.8 9590.9 9653.2 9662.5 7639.5 7899.5 7950.1 7998.4 8019.0 3077.4 3151.3 3154.1 3155.5 3192.0 788.5 799.7 956.4 968.3 1018.1 27261.0 28927.4 30242.0 31722.7 32189.4 907.2 928.7 959.8 962.9 1024.6 13979.8 14033.0 14113.3 14297.2 14361.9 177934.0 178077.0 178725.0 179618.1 179714.0 47572.0 47992.3 48052.5 48080.3 48096.8 1059.0 1118.0 1118.7 1165.3 1168.6 26659.2 28383.6 29435.6 30632.0 30682.2 46966.8 47771.8 47816.0 47848.0 47877.0 340221.0 341754.0 341772.0 343728.0 344328.0 24976.8 25127.7 25389.1 26066.2 26163.0 40407.2 41064.4 41942.2 42031.8 42133.6 35173.5 35310.3 35493.3 35821.8 36095.8 35498.5 35926.2 35954.8 36239.3 36577.5 34381.0 34894.0 34997.8 35257.8 35909.6 30546.7 32751.0 32829.3 32936.5 33098.5 25378.0 26769.5 27043.7 27137.5 27240.6 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | [#2] jquery.html Cycles:180 Average:19369.28 Median:4344.23 stddev:43930.79 (1011.2%) stddev-sans-first:44030.78 13:08:51 INFO - PROCESS | 3422 | Values: 334.4 346.1 361.3 364.1 387.1 12019.9 15508.4 16009.3 17406.9 17450.0 14518.6 15926.4 16403.8 16840.6 16927.2 4291.6 4736.5 4984.6 5151.6 5232.6 5072.8 5153.2 5161.3 5163.6 5172.3 4930.5 5045.6 5123.0 5143.2 5147.7 5059.0 5106.9 5116.2 5117.9 5119.8 4396.9 4428.2 4441.3 4608.0 4617.9 19422.5 19583.6 20377.8 20487.6 20656.7 1901.8 2140.8 2159.8 2292.5 2345.1 11836.0 12346.8 13122.8 13185.3 13811.6 1687.9 1690.9 1691.0 1709.2 1718.0 64867.4 65213.0 65620.7 66322.0 66696.7 9516.8 9581.7 9827.4 9850.9 9930.7 13333.8 13344.1 13350.3 13402.2 13417.3 6262.2 6669.7 6681.1 6688.9 6876.7 6206.0 6258.2 6415.9 6418.7 6474.2 4145.9 4162.8 4165.0 4171.4 4230.6 1667.9 1764.1 1779.7 1789.1 1800.9 649.5 804.6 812.7 844.4 849.2 16068.4 16250.5 16434.5 16465.7 17111.2 816.1 818.1 834.4 837.2 911.0 9184.6 9214.1 9635.0 9689.7 9890.5 129532.0 129540.4 129773.0 373924.1 377199.0 71021.3 72527.3 73044.3 74863.6 75023.6 889.7 904.9 909.9 924.7 928.5 14195.0 14319.7 14339.6 14931.3 15389.6 35108.0 35251.8 35532.0 35891.5 36041.3 46931.0 47252.0 47401.3 47828.0 49829.3 4816.2 7737.5 7801.9 7901.7 8032.9 10911.9 11893.8 12035.4 12062.6 12178.6 9925.7 10039.5 10382.7 10386.4 11029.2 9808.3 9993.5 10054.5 10082.1 10097.7 9888.2 10016.2 10264.8 10274.1 10471.0 7860.4 7941.0 8057.4 8135.3 8183.6 8918.8 10431.7 10473.9 10740.6 10875.7 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | [#3] mootools.html Cycles:180 Average:4789.91 Median:6033.71 stddev:2642.60 (43.8%) stddev-sans-first:2637.39 13:08:51 INFO - PROCESS | 3422 | Values: 1352.7 1360.4 1433.8 1621.5 1647.6 6287.8 6564.0 6928.2 7455.5 7462.0 7068.8 7344.5 7371.6 7541.2 7561.4 2067.5 2089.2 2104.4 2106.5 2108.7 1729.5 2075.9 2116.9 2124.9 2126.9 1704.9 2042.6 2110.9 2117.2 2137.2 2054.9 2055.1 2058.6 2067.9 2069.8 2045.8 2046.1 2047.9 2050.6 2056.2 7460.1 7473.3 7493.1 7525.0 7530.2 4169.4 4303.6 4339.8 4389.1 4404.2 2566.5 2721.5 2730.3 2735.9 2742.0 807.8 841.1 855.1 857.8 885.7 9602.0 9633.9 9660.3 9667.0 9667.3 3612.7 3642.2 3703.9 3797.0 3809.4 7879.0 7888.6 7890.0 7902.8 7903.0 4267.1 4273.3 4278.4 4279.6 4281.9 3971.5 3991.9 3995.4 3996.8 4001.2 3133.6 3227.2 3264.4 3295.1 3335.1 888.6 978.9 979.5 982.2 1002.6 689.8 785.6 803.7 812.5 820.9 4817.2 4926.3 4998.3 5010.8 5022.5 806.5 807.3 825.6 864.1 885.2 3299.8 3431.4 3440.0 3472.4 3617.5 8578.7 9013.8 9017.5 9026.7 9037.7 8438.4 8849.8 8911.6 8912.0 8928.3 6768.4 6944.3 6948.3 6951.7 6956.6 5027.9 5128.6 5161.8 5213.5 5310.3 8018.3 8071.4 8214.3 8297.1 8374.7 8180.8 8315.7 8388.1 8480.0 8506.6 6292.1 6405.6 6441.0 6441.4 6492.2 6978.5 7099.8 7111.4 7111.6 7120.9 6130.4 6270.7 6310.9 6415.1 6519.8 6281.7 6305.6 6319.4 6319.9 6341.3 5795.2 5897.5 5930.4 5931.8 5937.0 4355.3 4391.7 4409.6 4455.8 4580.1 4027.9 4389.9 4452.3 4482.9 4494.9 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | [#4] prototype.html Cycles:180 Average:4152.71 Median:4800.24 stddev:1201.89 (25.0%) stddev-sans-first:1169.68 13:08:51 INFO - PROCESS | 3422 | Values: 285.4 293.9 298.6 301.9 306.7 4812.6 4869.3 4870.3 4871.7 4890.8 4512.3 4602.9 4669.0 4733.6 4811.5 3781.1 3788.3 3788.3 3792.3 3796.2 3753.5 3755.5 3775.8 3777.5 3805.9 3486.1 3602.0 3668.8 3761.9 3771.9 3716.3 3722.9 3764.0 3764.1 3773.9 3315.5 3316.7 3326.9 3329.3 3342.9 4459.2 4651.2 4679.6 4680.9 4685.4 4211.8 4222.6 4231.6 4238.4 4240.7 5020.6 5021.9 5026.3 5028.5 5038.7 3528.9 3535.7 3538.9 3542.3 3546.2 4950.1 5186.6 5198.4 5200.0 5202.0 3608.6 3627.3 3632.5 3639.9 3644.5 3673.9 3679.7 3684.4 3686.5 3691.9 3960.6 4188.0 4194.8 4204.4 4213.1 4998.2 5015.5 5029.6 5031.8 5034.7 1267.9 1284.5 1285.2 1288.3 1289.2 777.1 790.1 840.8 878.1 879.8 4474.4 4481.6 4487.7 4493.8 4501.1 5114.2 5124.4 5129.8 5140.8 5162.6 4353.6 4420.0 4445.6 4467.5 4484.9 2712.4 2725.5 2728.7 2732.2 2732.9 4850.8 4855.0 4866.7 4906.6 4907.6 4984.8 5175.8 5182.7 5186.4 5217.5 4884.0 4912.7 4917.2 4922.1 4928.6 5143.9 5148.3 5150.4 5150.5 5166.4 4882.8 4956.9 4995.2 5013.4 5037.6 4872.5 4877.4 4879.3 4892.3 4911.3 3648.4 3657.1 3660.2 3661.1 3676.3 5018.8 5091.3 5119.9 5147.7 5158.3 4920.3 4944.3 4948.9 4958.2 4974.0 4954.0 4957.5 4985.6 5019.3 5035.9 4638.2 4862.4 4910.6 4916.9 4926.7 4788.9 4903.6 4931.0 4995.6 5069.5 4940.8 4948.9 4969.5 4980.8 4981.9 13:08:51 INFO - PROCESS | 3422 | 13:08:51 INFO - PROCESS | 3422 | [#5] yui.html Cycles:180 Average:15983.93 Median:44230.56 stddev:23064.40 (52.1%) stddev-sans-first:23100.10 13:08:51 INFO - PROCESS | 3422 | Values: 579.1 620.4 645.6 646.4 652.2 11577.6 12007.8 12325.4 12376.1 12957.7 12414.9 12603.4 12609.1 12648.1 12657.0 620.7 732.9 751.4 753.4 753.9 627.6 759.9 777.1 783.1 785.0 816.2 817.4 819.4 820.7 822.3 648.1 802.2 803.3 803.4 804.2 492.6 575.4 592.1 597.8 599.3 11052.7 11105.2 11144.2 11154.8 11161.6 11567.7 12006.8 12075.2 12338.3 12689.1 11229.3 11284.3 11507.8 11516.8 11607.0 4058.9 4167.1 4225.9 4248.4 4400.6 44109.3 44351.8 48725.3 59427.4 59532.4 9904.7 9976.9 10133.2 10272.1 10454.4 18310.8 18341.5 18345.6 18345.9 18363.5 6317.7 6332.9 6399.1 6610.2 6690.4 3542.3 3590.1 3603.2 3645.9 3650.2 2572.4 2652.6 2656.1 2656.5 2661.1 445.1 455.5 458.6 461.8 463.3 465.2 511.3 515.4 516.8 518.4 7041.0 7233.2 7334.5 7398.6 7421.4 410.5 413.8 429.4 490.2 494.1 3438.9 3503.9 3579.5 3583.6 3705.5 95707.0 96335.0 98716.5 100935.0 101782.0 29270.4 29403.9 29824.7 68070.0 84276.0 72734.3 74858.6 74946.6 78739.6 79647.6 6666.0 6698.8 6805.3 6826.2 6864.2 36073.0 36709.8 36896.3 40721.0 45986.0 54013.7 57843.7 58479.7 59846.7 62205.0 9579.3 9839.0 10251.8 10324.9 10410.2 10935.3 11352.9 11353.6 11375.0 11742.6 10483.4 11618.4 11800.4 11908.7 11911.4 11241.7 11754.5 11844.9 11864.3 11870.7 10665.4 11428.4 11529.2 11897.5 11929.3 8487.0 9267.9 9326.3 9654.5 9668.6 9007.4 9329.9 9961.8 10024.8 10096.6 13:08:51 INFO - PROCESS | 3422 | -------- Summary: end -------- 13:08:51 INFO - PROCESS | 3422 | 13:08:52 INFO - TEST-INFO | 3422: exit 0 13:08:52 INFO - TEST-OK | dromaeo_css | took 1123680ms 13:08:52 INFO - TEST-START | kraken 13:08:52 INFO - operating with platform_type : linux_ 13:08:52 INFO - Initialising browser for kraken test... 13:08:52 INFO - TEST-INFO | started process 3731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYpvkhg/profile http://localhost:57484/getInfo.html) 13:08:57 INFO - PROCESS | 3731 | __metrics Screen width/height:1600/1200 13:08:57 INFO - PROCESS | 3731 | colorDepth:24 13:08:57 INFO - PROCESS | 3731 | Browser inner width/height: 1024/697 13:08:57 INFO - PROCESS | 3731 | __metrics 13:08:57 INFO - PROCESS | 3731 | 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" 13:08:57 INFO - PROCESS | 3731 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:58 INFO - PROCESS | 3731 | console.error: PushService: 13:08:58 INFO - PROCESS | 3731 | stateChangeProcessEnqueue: Error transitioning state 13:08:58 INFO - PROCESS | 3731 | UnknownError 13:08:58 INFO - TEST-INFO | 3731: exit 0 13:08:58 INFO - Browser initialized. 13:08:58 INFO - Running cycle 1/1 for kraken test... 13:08:58 INFO - TEST-INFO | started process 3813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYpvkhg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:11 INFO - PROCESS | 3813 | RSS: Main: 175022080 13:09:11 INFO - PROCESS | 3813 | 13:09:13 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57484/tests/kraken/driver.html?testName=audio-beat-detection) 13:09:14 INFO - PROCESS | 3813 | RSS: Main: 233897984 13:09:14 INFO - PROCESS | 3813 | 13:09:17 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57484/tests/kraken/driver.html?testName=audio-dft) 13:09:18 INFO - PROCESS | 3813 | RSS: Main: 219000832 13:09:18 INFO - PROCESS | 3813 | 13:09:21 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57484/tests/kraken/driver.html?testName=audio-fft) 13:09:22 INFO - PROCESS | 3813 | RSS: Main: 301465600 13:09:22 INFO - PROCESS | 3813 | 13:09:24 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57484/tests/kraken/driver.html?testName=audio-oscillator) 13:09:25 INFO - PROCESS | 3813 | RSS: Main: 209739776 13:09:25 INFO - PROCESS | 3813 | 13:09:27 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57484/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:09:27 INFO - PROCESS | 3813 | RSS: Main: 214630400 13:09:27 INFO - PROCESS | 3813 | 13:09:31 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57484/tests/kraken/driver.html?testName=imaging-darkroom) 13:09:31 INFO - PROCESS | 3813 | RSS: Main: 250449920 13:09:31 INFO - PROCESS | 3813 | 13:09:35 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57484/tests/kraken/driver.html?testName=imaging-desaturate) 13:09:35 INFO - PROCESS | 3813 | RSS: Main: 244948992 13:09:35 INFO - PROCESS | 3813 | 13:09:38 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57484/tests/kraken/driver.html?testName=json-parse-financial) 13:09:39 INFO - PROCESS | 3813 | RSS: Main: 247160832 13:09:39 INFO - PROCESS | 3813 | 13:09:41 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57484/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:09:41 INFO - PROCESS | 3813 | RSS: Main: 210542592 13:09:41 INFO - PROCESS | 3813 | 13:09:43 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:09:44 INFO - PROCESS | 3813 | RSS: Main: 218165248 13:09:44 INFO - PROCESS | 3813 | 13:09:46 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:09:47 INFO - PROCESS | 3813 | RSS: Main: 227721216 13:09:47 INFO - PROCESS | 3813 | 13:09:49 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:09:50 INFO - PROCESS | 3813 | RSS: Main: 236756992 13:09:50 INFO - PROCESS | 3813 | 13:09:53 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:09:54 INFO - PROCESS | 3813 | RSS: Main: 233029632 13:09:54 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:57484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57484/tests/kraken/driver.html?testName=ai-astar) 13:09:56 INFO - PROCESS | 3813 | RSS: Main: 283262976 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | __start_tp_report 13:09:56 INFO - PROCESS | 3813 | _x_x_mozilla_page_load 13:09:56 INFO - PROCESS | 3813 | _x_x_mozilla_page_load_details 13:09:56 INFO - PROCESS | 3813 | |i|pagename|runs| 13:09:56 INFO - PROCESS | 3813 | |0;ai-astar;113;115;117;116;115;116;115;117;117;118 13:09:56 INFO - PROCESS | 3813 | |1;audio-beat-detection;155;134;134;174;131;127;132;131;177;128 13:09:56 INFO - PROCESS | 3813 | |2;audio-dft;161;160;161;161;162;159;162;164;161;161 13:09:56 INFO - PROCESS | 3813 | |3;audio-fft;77;76;76;123;76;77;76;78;98;75 13:09:56 INFO - PROCESS | 3813 | |4;audio-oscillator;84;91;119;83;84;83;106;83;83;120 13:09:56 INFO - PROCESS | 3813 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:09:56 INFO - PROCESS | 3813 | |6;imaging-darkroom;148;147;148;148;147;148;148;147;147;148 13:09:56 INFO - PROCESS | 3813 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;96;96 13:09:56 INFO - PROCESS | 3813 | |8;json-parse-financial;64;64;64;62;63;65;66;65;65;65 13:09:56 INFO - PROCESS | 3813 | |9;json-stringify-tinderbox;65;67;66;68;67;67;67;66;66;67 13:09:56 INFO - PROCESS | 3813 | |10;stanford-crypto-aes;84;84;85;91;87;89;83;84;91;87 13:09:56 INFO - PROCESS | 3813 | |11;stanford-crypto-ccm;140;148;144;144;138;147;138;138;175;150 13:09:56 INFO - PROCESS | 3813 | |12;stanford-crypto-pbkdf2;178;178;186;176;173;180;173;177;170;171 13:09:56 INFO - PROCESS | 3813 | |13;stanford-crypto-sha256-iterative;71;72;70;71;70;70;70;71;73;68 13:09:56 INFO - PROCESS | 3813 | __end_tp_report 13:09:56 INFO - PROCESS | 3813 | __start_cc_report 13:09:56 INFO - PROCESS | 3813 | _x_x_mozilla_cycle_collect,1921 13:09:56 INFO - PROCESS | 3813 | __end_cc_report 13:09:56 INFO - PROCESS | 3813 | __startTimestamp1475525396316__endTimestamp 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | ------- Summary: start ------- 13:09:56 INFO - PROCESS | 3813 | Number of tests: 14 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.50 stddev:1.45 (1.2%) stddev-sans-first:1.09 13:09:56 INFO - PROCESS | 3813 | Values: 113.0 115.0 117.0 116.0 115.0 116.0 115.0 117.0 117.0 118.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:134.00 stddev:19.17 (14.3%) stddev-sans-first:19.78 13:09:56 INFO - PROCESS | 3813 | Values: 155.0 134.0 134.0 174.0 131.0 127.0 132.0 131.0 177.0 128.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 13:09:56 INFO - PROCESS | 3813 | Values: 161.0 160.0 161.0 161.0 162.0 159.0 162.0 164.0 161.0 161.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.50 stddev:15.57 (20.4%) stddev-sans-first:16.35 13:09:56 INFO - PROCESS | 3813 | Values: 77.0 76.0 76.0 123.0 76.0 77.0 76.0 78.0 98.0 75.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:15.41 (18.6%) stddev-sans-first:15.95 13:09:56 INFO - PROCESS | 3813 | Values: 84.0 91.0 119.0 83.0 84.0 83.0 106.0 83.0 83.0 120.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:09:56 INFO - PROCESS | 3813 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 13:09:56 INFO - PROCESS | 3813 | Values: 148.0 147.0 148.0 148.0 147.0 148.0 148.0 147.0 147.0 148.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:09:56 INFO - PROCESS | 3813 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 13:09:56 INFO - PROCESS | 3813 | Values: 64.0 64.0 64.0 62.0 63.0 65.0 66.0 65.0 65.0 65.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.67 13:09:56 INFO - PROCESS | 3813 | Values: 65.0 67.0 66.0 68.0 67.0 67.0 67.0 66.0 66.0 67.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:2.99 (3.4%) stddev-sans-first:3.03 13:09:56 INFO - PROCESS | 3813 | Values: 84.0 84.0 85.0 91.0 87.0 89.0 83.0 84.0 91.0 87.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:145.50 stddev:11.04 (7.6%) stddev-sans-first:11.48 13:09:56 INFO - PROCESS | 3813 | Values: 140.0 148.0 144.0 144.0 138.0 147.0 138.0 138.0 175.0 150.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:177.50 stddev:4.76 (2.7%) stddev-sans-first:5.00 13:09:56 INFO - PROCESS | 3813 | Values: 178.0 178.0 186.0 176.0 173.0 180.0 173.0 177.0 170.0 171.0 13:09:56 INFO - PROCESS | 3813 | 13:09:56 INFO - PROCESS | 3813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 13:09:56 INFO - PROCESS | 3813 | Values: 71.0 72.0 70.0 71.0 70.0 70.0 70.0 71.0 73.0 68.0 13:09:56 INFO - PROCESS | 3813 | -------- Summary: end -------- 13:09:56 INFO - PROCESS | 3813 | 13:09:57 INFO - TEST-INFO | 3813: exit 0 13:09:57 INFO - TEST-OK | kraken | took 65135ms 13:09:57 INFO - SUITE-END | took 1188s 13:09:57 INFO - Completed test suite (00:19:49) 13:09:57 INFO - javascript benchmark 13:09:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.4595734895674, 2605.5961325994454, 2629.6187052877335, 2635.6046593011047, 2651.668541432321, 4495.033567782926, 4590.609798167152, 4631.027484228312, 4652.325412815144, 4663.510331415199, 4592.3341115538315, 4594.885127871797, 4610.077984403116, 4616.953830461694, 4620.029793743318, 4195.790210489478, 4212.7682977436225, 4221.535631080578, 4252.829886804524, 4284.571542845706, 4284.357346398034, 4287.078278170193, 4292.59220374064, 4335.176316499855, 4353.477582690081, 4283.37891005804, 4305.870823875289, 4323.5460276670965, 4325.243082460573, 4382.627476664487, 4360.215161270954, 4378.277584198603, 4388.407564978751, 4404.471463424377, 4407.669424793121, 4139.0, 4272.594103560157, 4282.464691913511, 4327.740335579844, 4337.980574564975, 4536.56902594253, 4543.31850222466, 4610.561996610317, 4648.953510464886, 4679.789409476548, 4816.710997340171, 4821.0357928414105, 4821.108095002436, 4838.032393521275, 4937.358143441365, 4856.198727210041, 4907.4356449008465, 4912.115819152551, 4920.360353154103, 4971.378577677754, 4494.955050449454, 4554.908901822011, 4572.3827283317, 4574.0, 4707.976460117678, 5069.417017043013, 5090.109230884655, 5090.2364645303505, 5094.2103973884105, 5143.074246635641, 4871.585915197248, 4891.144049791273, 4898.289747986522, 4902.460729319772, 4928.162212423897, 4778.235482322812, 4778.307145463888, 4829.034193161382, 4829.203181475017, 5002.074616195942, 4775.21209000511, 4778.665493415497, 4782.258749893772, 4824.831130910471, 4837.419509658793, 4739.3601863748645, 4759.785809638574, 4762.476127625959, 4769.856904292877, 4849.248366503198, 3994.6005399459823, 4023.1350259693722, 4027.134166154291, 4062.7608579383573, 4072.063425412172, 3570.589382221026, 3613.259281847215, 3629.2197177606413, 3706.5366829146355, 3732.682721968663, 4339.7396156230725, 4345.587169218919, 4347.282698354799, 4348.543402942709, 4405.977970110129, 4920.852374428773, 4946.579540739078, 4951.851444456672, 4977.278294647256, 5006.073876332817, 4170.937435938464, 4230.302000169999, 4322.589354011364, 4366.563343665672, 4368.235558777201, 4472.1502914446155, 4490.259107247268, 4494.617957473652, 4539.523350048197, 4551.499335073139, 4729.361536192639, 4738.691985020962, 4744.739039352799, 4745.908441058645, 4796.9280460792415, 4693.061387722538, 4809.350737650372, 4878.07316609843, 4890.926636100533, 4958.380202474691, 4683.976580117078, 4690.484046754923, 4724.149653062482, 4731.668783185144, 4734.0, 4885.755712214446, 4889.364382630235, 4891.26631005352, 4893.90212195747, 4944.777485013111, 4770.379850619397, 4813.470518243061, 4912.8771780705765, 4957.97521012407, 5001.599872010303, 4853.757312134449, 4881.121398148225, 4887.731174785279, 4937.604991600735, 4947.727874966911, 4878.365812444502, 4882.511748825089, 4882.902341953212, 4888.633352498506, 4950.430700469348, 4593.28804035375, 4644.558766917137, 4798.160321943716, 4807.903841923212, 4859.902801943871, 4824.372831532019, 4841.443234028132, 4872.244802055687, 4889.853304400874, 4949.257611358325, 4739.881502962454, 4764.190087685171, 4780.378550788375, 4829.179039563212, 4841.394825646794], "value": 4541.706139720795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.7206624621443, 559.6642014791125, 571.3714913595044, 582.7960213925126, 584.4681339980618, 27711.584326235097, 38502.80748596256, 39754.0, 39817.40273895887, 43360.783196083976, 39812.60187398125, 39939.20121597566, 40197.39703904444, 40240.0, 40287.19425611486, 7682.347000504949, 7832.490888092284, 7832.686692532292, 7836.80407989802, 7837.647305871249, 7231.421486281111, 7413.925860741405, 9876.35803672759, 10131.290809643328, 10131.89868101317, 10088.798224035514, 10199.898001019968, 10205.43870087145, 10206.64276750314, 10208.591656333738, 10050.346727462727, 10120.848187277197, 10126.949365253164, 10128.94935525325, 10133.493325333704, 9830.361026533252, 9899.109080182747, 9900.455474948874, 9902.356346837432, 9907.108360247612, 38101.61898381008, 38111.0, 38118.0, 38137.237255255015, 38141.80929095364, 2904.7966642335045, 3027.455058089543, 3051.6948305169526, 3116.98441507791, 3372.544706464645, 28200.76988451728, 28576.571351429746, 28640.71359286422, 28864.567031494546, 29273.56089658657, 3476.28736109097, 3557.0929412999776, 3572.6427357264324, 3585.515955346021, 3686.6129056448954, 250616.0, 252051.0, 252378.0, 252520.0, 252863.0, 31568.684313157035, 32757.344853102804, 51747.0, 52165.0, 52191.73904130455, 33495.162620934185, 33784.32431351359, 33811.66188338085, 33813.49279760806, 33830.0, 11927.403629818475, 12022.098342624338, 12033.217840840492, 12033.939830300793, 12034.0, 8678.522681252593, 8923.821523569492, 9590.856137157949, 9653.1794797443, 9662.468564228895, 7639.541627502367, 7899.526028438312, 7950.1254861965135, 7998.360131189491, 8019.0, 3077.3994426521026, 3151.306712523241, 3154.069549482908, 3155.542446345267, 3192.0, 788.5111231036794, 799.7360870912585, 956.3806813092746, 968.2931460034215, 1018.0532105142289, 27261.0, 28927.42145157085, 30242.0, 31722.68277317197, 32189.389253576337, 907.2016625369632, 928.661038720862, 959.7984423271191, 962.8892677342055, 1024.5850430575629, 13979.79030314546, 14033.0, 14113.294335283195, 14297.213653248964, 14361.928190358982, 177934.0, 178077.0, 178725.0, 179618.1019094896, 179714.0, 47572.0, 47992.28011579829, 48052.5194748055, 48080.27879581809, 48096.7595162022, 1058.9894101059044, 1117.9664610061548, 1118.692359601116, 1165.2542372881362, 1168.6143572621015, 26659.20022399331, 28383.574246386735, 29435.558466623446, 30632.0, 30682.232944176576, 46966.76516617395, 47771.761141195464, 47816.0, 47848.0, 47877.0, 340221.0, 341754.0, 341772.0, 343728.0, 344328.0, 24976.75302210701, 25127.74872251327, 25389.11138110157, 26066.218013459627, 26163.0, 40407.1918561633, 41064.384034238916, 41942.16115677731, 42031.7898410506, 42133.57866421297, 35173.47239791354, 35310.29379412449, 35493.29013419769, 35821.82089089538, 36095.81952090223, 35498.467522987696, 35926.233296394035, 35954.8202258987, 36239.275214495035, 36577.45133822942, 34381.0, 34894.0, 34997.82501087478, 35257.82371088231, 35909.64090359063, 30546.694533054386, 32751.0, 32829.34341313208, 32936.505952410254, 33098.5035224467, 25378.0, 26769.464610708066, 27043.72956270412, 27137.457250855266, 27240.591391128753], "value": 16402.76161084308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.4181124842771, 346.09841363248734, 361.345963805512, 364.10975165719816, 387.05558437412714, 12019.879801201996, 15508.371620979804, 16009.27958241879, 17406.912965435156, 17450.040247786368, 14518.637034074154, 15926.442574509894, 16403.83596164038, 16840.57898552534, 16927.153642317895, 4291.570842915699, 4736.455307639631, 4984.551390374856, 5151.562117220041, 5232.555232805216, 5072.771725272371, 5153.201253805666, 5161.251618515313, 5163.561097306733, 5172.301739265207, 4930.482299358569, 5045.571126454256, 5123.0, 5143.151380022292, 5147.691138531682, 5059.013492368989, 5106.897862042775, 5116.155834287357, 5117.872053198663, 5119.846404607868, 4396.89007774805, 4428.202923473774, 4441.333799930037, 4608.0, 4617.861464156081, 19422.47507823974, 19583.608327833364, 20377.796222037738, 20487.5902481951, 20656.690149647766, 1901.7717873855088, 2140.796624320687, 2159.838012149095, 2292.5414917016665, 2345.1323010486058, 11835.963271805509, 12346.75306493874, 13122.803157952638, 13185.34073296341, 13811.585652430444, 1687.8987260764393, 1690.8985460872264, 1690.9661806763918, 1709.1625103699223, 1718.0, 64867.351326486605, 65213.0, 65620.67189664069, 66322.0, 66696.6665166676, 9516.762080947894, 9581.712548623553, 9827.361221520578, 9850.852237216448, 9930.702078937644, 13333.799993000113, 13344.06591538583, 13350.265735384453, 13402.195868247936, 13417.262050587116, 6262.1859158310035, 6669.666516674147, 6681.064650948871, 6688.899666505006, 6876.724931002804, 6205.968970155121, 6258.15514905491, 6415.935840641534, 6418.679066046679, 6474.223093228843, 4145.8963525912095, 4162.791860406967, 4164.9583504165175, 4171.374293855885, 4230.576942305806, 1667.8665706743432, 1764.0914928811671, 1779.6796576616334, 1789.1322708486373, 1800.8649351298704, 649.4869053447818, 804.6419343392251, 812.7196117339508, 844.3751623798345, 849.163573879728, 16068.35726570924, 16250.512484625244, 16434.506964791075, 16465.67068658644, 17111.22999465027, 816.1348970091722, 818.145038434837, 834.4284165346756, 837.1753822484848, 910.9863352049724, 9184.632614695338, 9214.124658157465, 9635.0, 9689.660861869801, 9890.456024918554, 129532.0, 129540.35229823978, 129773.0, 373924.1303793464, 377199.0, 71021.27829136142, 72527.28572642761, 73044.26955730375, 74863.62568187124, 75023.62488187633, 889.7241855024963, 904.8733177355175, 909.8817153769968, 924.7364501117149, 928.4707716601472, 14195.0, 14319.713605727618, 14339.569812905629, 14931.253437328307, 15389.615259618598, 35108.0, 35251.82374088113, 35532.0, 35891.461628076126, 36041.279174416886, 46931.0, 47252.0, 47401.28898066463, 47828.0, 49829.25256121089, 4816.181249187576, 7737.458377913492, 7801.882971755542, 7901.723439679814, 8032.919670803451, 10911.945440272748, 11893.82159267629, 12035.398230088285, 12062.638120856389, 12178.634640960785, 9925.65260215889, 10039.498025098861, 10382.740431489274, 10386.428746418716, 11029.22795404314, 9808.313418060667, 9993.450360230258, 10054.54754536033, 10082.092611664986, 10097.747556311151, 9888.208943284664, 10016.1987041038, 10264.846027309746, 10274.126699230648, 10471.0, 7860.449768516149, 7941.0, 8057.355411567178, 8135.267825895698, 8183.590820459072, 8918.777030574287, 10431.739206519898, 10473.9476302618, 10740.624078157227, 10875.673729788119], "value": 7893.85946716032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.7294541091785, 1360.3742278551865, 1433.7634290342094, 1621.5378617094123, 1647.5798671338807, 6287.811365659026, 6563.967180164104, 6928.203256625489, 7455.4781165318445, 7462.0, 7068.823279418017, 7344.522606030604, 7371.63141842907, 7541.208173141809, 7561.395088392929, 2067.524469372045, 2089.1747759634936, 2104.4002459299104, 2106.547092375139, 2108.7153234313323, 1729.4638662014752, 2075.875467195253, 2116.883571403572, 2124.915003399862, 2126.9468263293465, 1704.940327088552, 2042.6323261812868, 2110.862793918398, 2117.216629846951, 2137.177186783092, 2054.897255137237, 2055.1368425261353, 2058.559008693905, 2067.8759274443582, 2069.803368679973, 2045.7545094588745, 2046.0997161249002, 2047.8668886522328, 2050.5796311756053, 2056.20835978148, 7460.104787425489, 7473.290037446434, 7493.100827900686, 7525.0, 7530.209328020534, 4169.353750168699, 4303.612674859246, 4339.7830108494445, 4389.144116897206, 4404.1852257332175, 2566.4995325911455, 2721.496523143205, 2730.331068888115, 2735.9042433514733, 2741.9588706169425, 807.757672698194, 841.0790184747691, 855.1234984141242, 857.7769779857219, 885.7342797160826, 9601.951990240073, 9633.903660963371, 9660.323777335589, 9666.951665241699, 9667.323287369958, 3612.710983121344, 3642.1805093853673, 3703.9074023149637, 3796.981015094962, 3809.3904975203836, 7879.0, 7888.64501097452, 7889.960550197212, 7902.841943161219, 7902.960485197537, 4267.061246525759, 4273.337632666941, 4278.4010238566625, 4279.614834664895, 4281.892952676208, 3971.5035620547433, 3991.900202494961, 3995.4406383105807, 3996.800159991989, 4001.239764444746, 3133.5613014178034, 3227.1609381560493, 3264.4450443424676, 3295.110320213577, 3335.116194208537, 888.5868071346855, 978.9021097890296, 979.5151400057017, 982.2387649571639, 1002.6089824968268, 689.8344397344702, 785.6346798738614, 803.6785285885693, 812.4597142900024, 820.8713019598052, 4817.159633320693, 4926.285688575136, 4998.2502624606595, 5010.774515146827, 5022.547970682656, 806.4516129032197, 807.3420162567606, 825.5954582254652, 864.0711235421946, 885.154677283193, 3299.802011879295, 3431.433813420758, 3440.0, 3472.392331342005, 3617.5478065241846, 8578.742637720878, 9013.819723605491, 9017.458952462874, 9026.684066057656, 9037.683681071263, 8438.36712246584, 8849.778755531162, 8911.598978046004, 8911.955440222757, 8928.330375221884, 6768.424683901923, 6944.2708515607155, 6948.305169483112, 6951.721931122698, 6956.617386043715, 5027.949720502748, 5128.564072053917, 5161.8451446455165, 5213.478652134756, 5310.283111780015, 8018.3184429324165, 8071.394645401736, 8214.26071653554, 8297.08732039463, 8374.706885259231, 8180.754577362689, 8315.667373305241, 8388.119247479171, 8480.024797148408, 8506.574671266535, 6292.087647291209, 6405.551611387158, 6441.0, 6441.420272175526, 6492.156019717596, 6978.47661425385, 7099.787006389816, 7111.395531379891, 7111.573305601681, 7120.928790712027, 6130.448259656652, 6270.655113968775, 6310.873782524232, 6415.06981487691, 6519.750686013318, 6281.654509002049, 6305.558610897377, 6319.399657032574, 6319.936800631935, 6341.334159913143, 5795.24661793981, 5897.5281977440845, 5930.436608522184, 5931.7627294907725, 5936.970315148569, 4355.346697995326, 4391.736495810262, 4409.64722822167, 4455.7994890229365, 4580.0610874771255, 4027.899302517343, 4389.868303950887, 4452.287633978548, 4482.887927801831, 4494.910101798011], "value": 3867.5191560172066, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.3593682183498, 293.87657183982714, 298.55366227489907, 301.8762307453944, 306.6718611086139, 4812.566868981791, 4869.293952376903, 4870.293807397925, 4871.658983871131, 4890.779914903829, 4512.255477846152, 4602.884927876797, 4669.0, 4733.621310295177, 4811.542903424178, 3781.149241420686, 3788.2802267569214, 3788.299164654534, 3792.2745150956384, 3796.1648437343742, 3753.51204343435, 3755.530558680165, 3775.8300876460626, 3777.452269420932, 3805.885823425288, 3486.1284678830293, 3601.963980360202, 3668.816559172031, 3761.9435708464257, 3771.9061472173175, 3716.312482190803, 3722.925541489155, 3763.9811800941093, 3764.0778009387736, 3773.8867833964887, 3315.4860996545576, 3316.6849149330774, 3326.8835590754206, 3329.317489914586, 3342.916427089318, 4459.241928872099, 4651.209294419923, 4679.64902632304, 4680.946786972938, 4685.367475390813, 4211.789410529492, 4222.577742225783, 4231.566849061771, 4238.4490016298, 4240.724352917081, 5020.573251273646, 5021.920287138283, 5026.346574945233, 5028.547430731252, 5038.748062596892, 3528.947065794015, 3535.656450548801, 3538.9115272118147, 3542.256126213498, 3546.1666508370513, 4950.133726597867, 5186.559142472895, 5198.376194856603, 5199.974000130013, 5202.0, 3608.6210947850623, 3627.3470775260707, 3632.4914511968345, 3639.8726044588843, 3644.5444319460066, 3673.8530458781884, 3679.7121007647643, 3684.3920753075977, 3686.465462507975, 3691.8892433227047, 3960.5643379228836, 4187.973946383156, 4194.762545049218, 4204.3693445983345, 4213.136307057046, 4998.2002879539095, 5015.4733752956145, 5029.622778291569, 5031.77357018935, 5034.677113105333, 1267.9429425675867, 1284.4990453723055, 1285.2160182288796, 1288.2978776566792, 1289.232906420678, 777.1257335497565, 790.1190172957112, 840.844443777903, 878.1394233651058, 879.8152387998464, 4474.39595654589, 4481.551844815493, 4487.6634252431195, 4493.775311234491, 4501.144782491317, 5114.181730923035, 5124.410692770304, 5129.79480820763, 5140.845774626767, 5162.6386152968935, 4353.586409291112, 4420.0, 4445.555444455528, 4467.508574056851, 4484.932726009112, 2712.362594790223, 2725.514594545977, 2728.727127287295, 2732.2486316263185, 2732.904348347838, 4850.805967761321, 4854.951450485521, 4866.7079975200895, 4906.632002599819, 4907.5828554572545, 4984.800607975641, 5175.818846340435, 5182.689038657617, 5186.40356359016, 5217.50433708797, 4883.973151142236, 4912.70523768575, 4917.188663870421, 4922.138625740481, 4928.6303527235605, 5143.948560514496, 5148.279240906201, 5150.381954165524, 5150.48495150482, 5166.3800343958965, 4882.776398415416, 4956.900861982668, 4995.226694523391, 5013.39839219296, 5037.571806396498, 4872.465173470346, 4877.365942427604, 4879.292502587176, 4892.339534162985, 4911.263310503453, 3648.416253399443, 3657.085728567858, 3660.2496488220386, 3661.0664280608275, 3676.28312479064, 5018.84943451697, 5091.287219789307, 5119.92320115206, 5147.6654017488745, 5158.3294171758935, 4920.31115643803, 4944.283078953604, 4948.925766113439, 4958.181899986462, 4974.0, 4953.993632578811, 4957.463186412224, 4985.5762260208285, 5019.272205530105, 5035.899282014266, 4638.234691276037, 4862.41651001882, 4910.607151427806, 4916.8770780730765, 4926.704397736147, 4788.928166077581, 4903.6077113831525, 4930.975345123252, 4995.575376093073, 5069.493050694901, 4940.777665005012, 4948.925766113583, 4969.453360130455, 4980.825671101494, 4981.875453113701], "value": 3769.5920380311695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.111064515968, 620.4199073865935, 645.5965021861334, 646.4117652935828, 652.1522021372215, 11577.594784182555, 12007.759844803099, 12325.383730813468, 12376.13367064306, 12957.74084518309, 12414.937925310383, 12603.432845521951, 12609.054320925921, 12648.114631975743, 12657.0, 620.6834514397667, 732.9157146928118, 751.3801114080878, 753.4462170304821, 753.8605358008786, 627.6202897247168, 759.9012128423298, 777.141258908906, 783.1463704562026, 785.0265670568483, 816.1512027491402, 817.3542901108148, 819.3731795176694, 820.6840366458897, 822.2558584481054, 648.1088503307951, 802.1577343788998, 803.3051410529879, 803.445622520459, 804.1837534902049, 492.57392355612495, 575.3728436004775, 592.1000079878561, 597.8206538038571, 599.3437186281016, 11052.668419947415, 11105.167112466517, 11144.219904606682, 11154.832677509843, 11161.553537858475, 11567.652970410816, 12006.819897701542, 12075.154739168262, 12338.259704417675, 12689.111762176652, 11229.3262404256, 11284.32294062359, 11507.827382589268, 11516.827247591293, 11607.0, 4058.8782336529953, 4167.1457351242925, 4225.852095176654, 4248.4052232687445, 4400.603945644907, 44109.33835992463, 44351.77824110859, 48725.26912096321, 59427.40572594305, 59532.40467595312, 9904.653337133166, 9976.900230997742, 10133.18934485254, 10272.075513203847, 10454.42500662471, 18310.81689183118, 18341.54146146357, 18345.633087338447, 18345.908270458563, 18363.54091147732, 6317.747290108436, 6332.873342533124, 6399.104125422445, 6610.206775187008, 6690.364415380531, 3542.2915416916203, 3590.1024743814046, 3603.1532589841368, 3645.8906232813056, 3650.1969566695284, 2572.3954870605394, 2652.562327215988, 2656.0969270447754, 2656.5085459190113, 2661.055325359508, 445.1408781052535, 455.4511813265008, 458.61476359857215, 461.7621924708778, 463.3212343916179, 465.21611085320666, 511.2765436906735, 515.3841159814061, 516.7855340033843, 518.3572370260924, 7041.0, 7233.1681856587165, 7334.523255988343, 7398.593077380688, 7421.443391745641, 410.4950910380249, 413.84687665563933, 429.3666841408897, 490.1838438999098, 494.05142127115306, 3438.8796392126155, 3503.9474407883904, 3579.534660494119, 3583.605803361628, 3705.5299057181746, 95707.0, 96335.0, 98716.53208669841, 100935.0, 101782.0, 29270.414591708046, 29403.852980735388, 29824.701752982193, 68070.0, 84276.0, 72734.2726572738, 74858.62570687111, 74946.62526687332, 78739.60630196812, 79647.60176199197, 6666.033425153229, 6698.799036028927, 6805.319468053155, 6826.214985276757, 6864.1762988439705, 36073.0, 36709.81645091758, 36896.26207475782, 40721.0, 45986.0, 54013.72993135009, 57843.71078144582, 58479.70760146172, 59846.70076649589, 62205.0, 9579.329446938647, 9839.044652128581, 10251.794964100527, 10324.896751032393, 10410.219233557362, 10935.343879367263, 11352.943235284101, 11353.572584862768, 11374.976252137347, 11742.58900938463, 10483.423411712429, 11618.419079046183, 11800.379152564134, 11908.702282443008, 11911.404429778304, 11241.71895702614, 11754.471048802654, 11844.940775296069, 11864.347460889388, 11870.703232419259, 10665.41340226295, 11428.428578571204, 11529.1929564933, 11897.524099035942, 11929.28424294545, 8487.0, 9267.86098208514, 9326.300527460604, 9654.517274136406, 9668.613255469983, 9007.414518056305, 9329.86005209936, 9961.750956226153, 10024.799504010025, 10096.596136154472], "value": 6090.358232060224, "unit": "score"}], "name": "dromaeo_css", "value": 6113.746952952235, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 117.0, 116.0, 115.0, 116.0, 115.0, 117.0, 117.0, 118.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 134.0, 134.0, 174.0, 131.0, 127.0, 132.0, 131.0, 177.0, 128.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 159.0, 162.0, 164.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 123.0, 76.0, 77.0, 76.0, 78.0, 98.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 119.0, 83.0, 84.0, 83.0, 106.0, 83.0, 83.0, 120.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 62.0, 63.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 91.0, 87.0, 89.0, 83.0, 84.0, 91.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 148.0, 144.0, 144.0, 138.0, 147.0, 138.0, 138.0, 175.0, 150.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 186.0, 176.0, 173.0, 180.0, 173.0, 177.0, 170.0, 171.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 70.0, 71.0, 70.0, 70.0, 70.0, 71.0, 73.0, 68.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1566.9, "alertThreshold": 2.0}]} 13:09:58 INFO - Return code: 0 13:09:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:09:58 INFO - # TBPL SUCCESS # 13:09:58 INFO - Running post-action listener: _resource_record_post_action 13:09:58 INFO - [mozharness: 2016-10-03 20:09:58.123355Z] Finished run-tests step (success) 13:09:58 INFO - Running post-run listener: _resource_record_post_run 13:09:58 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 7778304; Write bytes: 422318080; Read time: 1728; Write time: 397564 13:09:58 INFO - TinderboxPrint: CPU usage
13.0% 13:09:58 INFO - TinderboxPrint: I/O read bytes / time
7,778,304 / 1,728 13:09:58 INFO - TinderboxPrint: I/O write bytes / time
422,318,080 / 397,564 13:09:58 INFO - TinderboxPrint: CPU idle
8,368.7 (87.0%) 13:09:58 INFO - TinderboxPrint: CPU user
1,202.2 (12.5%) 13:09:58 INFO - TinderboxPrint: Swap in / out
0 / 0 13:09:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 85872640; Read time: 0; Write time: 66996 13:09:58 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 5566464; Write bytes: 336445440; Read time: 1560; Write time: 330568 13:09:58 INFO - Running post-run listener: _upload_blobber_files 13:09:58 INFO - Blob upload gear active. 13:09:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:09:58 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 13:09:58 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:09:58 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:09:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:59 INFO - (blobuploader) - INFO - Done attempting. 13:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:00 INFO - (blobuploader) - INFO - Done attempting. 13:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:10:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:04 INFO - (blobuploader) - INFO - Done attempting. 13:10:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:10:04 INFO - Return code: 0 13:10:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:10:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:10:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/34e6b87af2eba743897f899e079815bfb87af92e7d7e38efce272840e085ca82aecc560a6ba3537913308b2bd5c1ce803863e62a9df059b9e36bfafce055e4f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/36270c303eaff8939acb4a6bedbff4e70a33ed423a7f0ed57657643b32583a69e74037e39a339f69560dcd94825787785a17addbfd79a83baefc2061aadfe1bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62457a177b020bf0333177f2e3acc35e0afadca05d6b3507c355b122b22c8d6f54886ff8cfea4a2ab341c9eb5049c0eb65b53aed88ef596741c64dd7120a0d5f"} 13:10:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:10:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:10:04 INFO - Contents: 13:10:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/34e6b87af2eba743897f899e079815bfb87af92e7d7e38efce272840e085ca82aecc560a6ba3537913308b2bd5c1ce803863e62a9df059b9e36bfafce055e4f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/36270c303eaff8939acb4a6bedbff4e70a33ed423a7f0ed57657643b32583a69e74037e39a339f69560dcd94825787785a17addbfd79a83baefc2061aadfe1bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62457a177b020bf0333177f2e3acc35e0afadca05d6b3507c355b122b22c8d6f54886ff8cfea4a2ab341c9eb5049c0eb65b53aed88ef596741c64dd7120a0d5f"} 13:10:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:10:04 INFO - Copying logs to upload dir... 13:10:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:10:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.112786 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-10-03 13:10:04.308235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:04.312123) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/34e6b87af2eba743897f899e079815bfb87af92e7d7e38efce272840e085ca82aecc560a6ba3537913308b2bd5c1ce803863e62a9df059b9e36bfafce055e4f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/36270c303eaff8939acb4a6bedbff4e70a33ed423a7f0ed57657643b32583a69e74037e39a339f69560dcd94825787785a17addbfd79a83baefc2061aadfe1bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62457a177b020bf0333177f2e3acc35e0afadca05d6b3507c355b122b22c8d6f54886ff8cfea4a2ab341c9eb5049c0eb65b53aed88ef596741c64dd7120a0d5f"} build_url:https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/HK0MfHKFRLWrI59gED-FPQ/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/Autoland-Non-PGO/sha512/34e6b87af2eba743897f899e079815bfb87af92e7d7e38efce272840e085ca82aecc560a6ba3537913308b2bd5c1ce803863e62a9df059b9e36bfafce055e4f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/36270c303eaff8939acb4a6bedbff4e70a33ed423a7f0ed57657643b32583a69e74037e39a339f69560dcd94825787785a17addbfd79a83baefc2061aadfe1bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62457a177b020bf0333177f2e3acc35e0afadca05d6b3507c355b122b22c8d6f54886ff8cfea4a2ab341c9eb5049c0eb65b53aed88ef596741c64dd7120a0d5f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:04.337557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:04.337941) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1475522551.39172-942342640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:04.421685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:10:04.422041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:10:04.422365) ========= ========= Total master_lag: 0.20 =========