builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0309 starttime: 1484584975.32 results: success (0) buildid: 20170116073621 builduid: e90f396fecc742068bab56ae6f9a936a revision: d4d3a7b6d57e06891f158ccb4bebf507a8d55d32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.319636) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.320099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.320374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.372577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.372913) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.20vHCTAfjZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-16 08:42:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.9M=0.001s 2017-01-16 08:42:55 (21.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.484899 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.896844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.897208) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.20vHCTAfjZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.029253 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:55.948491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 08:42:55.948815) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d4d3a7b6d57e06891f158ccb4bebf507a8d55d32 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d4d3a7b6d57e06891f158ccb4bebf507a8d55d32 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.20vHCTAfjZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-16 08:42:56,047 truncating revision to first 12 chars 2017-01-16 08:42:56,047 Setting DEBUG logging. 2017-01-16 08:42:56,047 attempt 1/10 2017-01-16 08:42:56,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d4d3a7b6d57e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 08:42:57,033 unpacking tar archive at: mozilla-central-d4d3a7b6d57e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 08:42:57.217753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:57.221247) ========= script_repo_revision: d4d3a7b6d57e06891f158ccb4bebf507a8d55d32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:57.221760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:57.222054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 08:42:57.243578) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-16 08:42:57.243974) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.20vHCTAfjZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:42:57 INFO - MultiFileLogger online at 20170116 08:42:57 in /builds/slave/test 08:42:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:42:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:57 INFO - {'append_to_log': False, 08:42:57 INFO - 'base_work_dir': '/builds/slave/test', 08:42:57 INFO - 'blob_upload_branch': 'Firefox', 08:42:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:57 INFO - 'branch': 'Firefox', 08:42:57 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:57 INFO - 'config_files': ('talos/mac_config.py',), 08:42:57 INFO - 'default_actions': ('clobber', 08:42:57 INFO - 'read-buildbot-config', 08:42:57 INFO - 'download-and-extract', 08:42:57 INFO - 'populate-webroot', 08:42:57 INFO - 'create-virtualenv', 08:42:57 INFO - 'install', 08:42:57 INFO - 'run-tests'), 08:42:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:57 INFO - 'download_minidump_stackwalk': True, 08:42:57 INFO - 'download_symbols': 'ondemand', 08:42:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:57 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:57 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:57 INFO - 'installer_path': 'installer.exe', 08:42:57 INFO - 'log_level': 'info', 08:42:57 INFO - 'log_name': 'talos', 08:42:57 INFO - 'log_to_console': True, 08:42:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:42:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:42:57 INFO - 'opt_config_files': (), 08:42:57 INFO - 'pip_index': False, 08:42:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:57 INFO - 'cmd': ('bash', 08:42:57 INFO - '-c', 08:42:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:57 INFO - 'enabled': True, 08:42:57 INFO - 'halt_on_failure': False, 08:42:57 INFO - 'name': 'check_screen_resolution'},), 08:42:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:57 INFO - 'cmd': ('bash', 08:42:57 INFO - '-c', 08:42:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:57 INFO - 'enabled': True, 08:42:57 INFO - 'halt_on_failure': False, 08:42:57 INFO - 'name': 'check_screen_resolution'},), 08:42:57 INFO - 'run_cmd_checks_enabled': True, 08:42:57 INFO - 'sps_profile': False, 08:42:57 INFO - 'sps_profile_interval': 0, 08:42:57 INFO - 'suite': 'dromaeojs', 08:42:57 INFO - 'system_bits': '32', 08:42:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:57 INFO - 'title': 't-yosemite-r7-0309', 08:42:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:57 INFO - 'use_talos_json': True, 08:42:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:57 INFO - 'work_dir': 'build'} 08:42:57 INFO - [mozharness: 2017-01-16 16:42:57.450225Z] Running clobber step. 08:42:57 INFO - Running pre-action listener: _resource_record_pre_action 08:42:57 INFO - Running main action method: clobber 08:42:57 INFO - rmtree: /builds/slave/test/build 08:42:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:59 INFO - Running post-action listener: _resource_record_post_action 08:42:59 INFO - [mozharness: 2017-01-16 16:42:59.844303Z] Finished clobber step (success) 08:42:59 INFO - [mozharness: 2017-01-16 16:42:59.844491Z] Running read-buildbot-config step. 08:42:59 INFO - Running pre-action listener: _resource_record_pre_action 08:42:59 INFO - Running main action method: read_buildbot_config 08:42:59 INFO - Using buildbot properties: 08:42:59 INFO - { 08:42:59 INFO - "project": "", 08:42:59 INFO - "product": "firefox", 08:42:59 INFO - "script_repo_revision": "production", 08:42:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:42:59 INFO - "repository": "", 08:42:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:42:59 INFO - "buildid": "20170116073621", 08:42:59 INFO - "pgo_build": "False", 08:42:59 INFO - "basedir": "/builds/slave/test", 08:42:59 INFO - "buildnumber": 16, 08:42:59 INFO - "slavename": "t-yosemite-r7-0309", 08:42:59 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:42:59 INFO - "platform": "yosemite_r7", 08:42:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:42:59 INFO - "branch": "mozilla-central", 08:42:59 INFO - "repo_path": "mozilla-central", 08:42:59 INFO - "revision": "d4d3a7b6d57e06891f158ccb4bebf507a8d55d32", 08:42:59 INFO - "stage_platform": "macosx64", 08:42:59 INFO - "builduid": "e90f396fecc742068bab56ae6f9a936a", 08:42:59 INFO - "slavebuilddir": "test" 08:42:59 INFO - } 08:42:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:42:59 INFO - Running post-action listener: _resource_record_post_action 08:42:59 INFO - [mozharness: 2017-01-16 16:42:59.847847Z] Finished read-buildbot-config step (success) 08:42:59 INFO - [mozharness: 2017-01-16 16:42:59.847963Z] Running download-and-extract step. 08:42:59 INFO - Running pre-action listener: _resource_record_pre_action 08:42:59 INFO - Running main action method: download_and_extract 08:42:59 INFO - mkdir: /builds/slave/test/build/tests 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:59 INFO - trying https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:42:59 INFO - Downloading https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:43:00 INFO - Downloaded 1199 bytes. 08:43:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:43:00 INFO - Using the following test package requirements: 08:43:00 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:43:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:43:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:43:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'jsshell-mac.zip'], 08:43:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:43:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:43:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:43:00 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:43:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:43:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:43:00 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:43:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:43:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:43:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:43:00 INFO - Fetch https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:43:02 INFO - Expected file size: 16325879 08:43:02 INFO - Obtained file size: 16325879 08:43:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:43:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:43:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:43:08 INFO - Fetch https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:43:09 INFO - Expected file size: 16325879 08:43:09 INFO - Obtained file size: 16325879 08:43:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:43:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:43:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:43:17 INFO - Expected file size: 14403463 08:43:17 INFO - Obtained file size: 14403463 08:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:18 INFO - trying https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:43:18 INFO - Downloading https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:43:20 INFO - Downloaded 70121673 bytes. 08:43:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:43:20 INFO - mkdir: /builds/slave/test/properties 08:43:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:20 INFO - Contents: 08:43:20 INFO - build_url:https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:43:21 INFO - Running post-action listener: _resource_record_post_action 08:43:21 INFO - Running post-action listener: set_extra_try_arguments 08:43:21 INFO - [mozharness: 2017-01-16 16:43:21.909493Z] Finished download-and-extract step (success) 08:43:21 INFO - [mozharness: 2017-01-16 16:43:21.909637Z] Running populate-webroot step. 08:43:21 INFO - Running pre-action listener: _resource_record_pre_action 08:43:21 INFO - Running main action method: populate_webroot 08:43:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:21 INFO - '--tppagecycles', 08:43:21 INFO - '7'], 08:43:21 INFO - 'tests': ['tsvgm']}}, 08:43:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:43:21 INFO - 'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:43:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:43:21 INFO - 'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['damp', 'tps']}, 08:43:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:43:21 INFO - 'tests': ['damp', 'tps']}, 08:43:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['dromaeo_dom']}, 08:43:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['basic_compositor_video']}, 08:43:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:43:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['a11yr', 08:43:21 INFO - 'ts_paint', 08:43:21 INFO - 'tpaint', 08:43:21 INFO - 'sessionrestore', 08:43:21 INFO - 'sessionrestore_no_auto_restore', 08:43:21 INFO - 'tabpaint']}, 08:43:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:21 INFO - 'ts_paint', 08:43:21 INFO - 'tpaint', 08:43:21 INFO - 'sessionrestore', 08:43:21 INFO - 'sessionrestore_no_auto_restore', 08:43:21 INFO - 'tabpaint']}, 08:43:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:21 INFO - 'ts_paint', 08:43:21 INFO - 'tpaint', 08:43:21 INFO - 'sessionrestore', 08:43:21 INFO - 'sessionrestore_no_auto_restore', 08:43:21 INFO - 'tabpaint']}, 08:43:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:21 INFO - 'ts_paint', 08:43:21 INFO - 'tpaint', 08:43:21 INFO - 'sessionrestore', 08:43:21 INFO - 'sessionrestore_no_auto_restore', 08:43:21 INFO - 'tabpaint']}, 08:43:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['a11yr', 08:43:21 INFO - 'ts_paint', 08:43:21 INFO - 'tpaint', 08:43:21 INFO - 'sessionrestore', 08:43:21 INFO - 'sessionrestore_no_auto_restore', 08:43:21 INFO - 'tabpaint']}, 08:43:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['a11yr', 08:43:21 INFO - 'ts_paint', 08:43:21 INFO - 'tpaint', 08:43:21 INFO - 'sessionrestore', 08:43:21 INFO - 'sessionrestore_no_auto_restore', 08:43:21 INFO - 'tabpaint']}, 08:43:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['tsvgx', 08:43:21 INFO - 'tsvgr_opacity', 08:43:21 INFO - 'tart', 08:43:21 INFO - 'tscrollx', 08:43:21 INFO - 'cart', 08:43:21 INFO - 'tsvg_static']}, 08:43:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:21 INFO - 'tsvgr_opacity', 08:43:21 INFO - 'tart', 08:43:21 INFO - 'tscrollx', 08:43:21 INFO - 'cart', 08:43:21 INFO - 'tsvg_static']}, 08:43:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:43:21 INFO - 'talos_options': ['--disable-e10s'], 08:43:21 INFO - 'tests': ['tp5o']}, 08:43:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:43:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:43:21 INFO - 'talos_options': ['--disable-e10s', 08:43:21 INFO - '--xperf_path', 08:43:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:21 INFO - 'tests': ['tp5n']}, 08:43:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:43:21 INFO - 'talos_options': ['--xperf_path', 08:43:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:21 INFO - 'tests': ['tp5n']}}, 08:43:21 INFO - 'talos.zip': {'path': '', 08:43:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:21 INFO - Running post-action listener: _resource_record_post_action 08:43:21 INFO - [mozharness: 2017-01-16 16:43:21.928214Z] Finished populate-webroot step (success) 08:43:21 INFO - [mozharness: 2017-01-16 16:43:21.928349Z] Running create-virtualenv step. 08:43:21 INFO - Running pre-action listener: _resource_record_pre_action 08:43:21 INFO - Running main action method: create_virtualenv 08:43:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:21 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 08:43:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:22 INFO - Using real prefix '/tools/python27' 08:43:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:25 INFO - Installing pip.................done. 08:43:25 INFO - Return code: 0 08:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:43:25 INFO - Reading from file tmpfile_stdout 08:43:25 INFO - Output received: 08:43:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:43:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:25 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 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43:25 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 08:43:25 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 08:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:25 INFO - 'HOME': '/Users/cltbld', 08:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:25 INFO - 'LOGNAME': 'cltbld', 08:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:25 INFO - 'MOZ_NO_REMOTE': '1', 08:43:25 INFO - 'NO_EM_RESTART': '1', 08:43:25 INFO - 'PAGER': '/bin/cat', 08:43:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:25 INFO - 'PWD': '/builds/slave/test', 08:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:25 INFO - 'SHELL': '/bin/bash', 08:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:25 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:25 INFO - 'USER': 'cltbld', 08:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:25 INFO - 'XPC_FLAGS': '0x0', 08:43:25 INFO - 'XPC_SERVICE_NAME': '0', 08:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:26 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 08:43:26 INFO - Cleaning up... 08:43:26 INFO - Return code: 0 08:43:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:26 INFO - 'HOME': '/Users/cltbld', 08:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:26 INFO - 'LOGNAME': 'cltbld', 08:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:26 INFO - 'MOZ_NO_REMOTE': '1', 08:43:26 INFO - 'NO_EM_RESTART': '1', 08:43:26 INFO - 'PAGER': '/bin/cat', 08:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:26 INFO - 'PWD': '/builds/slave/test', 08:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:26 INFO - 'SHELL': '/bin/bash', 08:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:26 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:26 INFO - 'USER': 'cltbld', 08:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:26 INFO - 'XPC_FLAGS': '0x0', 08:43:26 INFO - 'XPC_SERVICE_NAME': '0', 08:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:26 INFO - Downloading/unpacking psutil>=3.1.1 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:30 INFO - Installing collected packages: psutil 08:43:30 INFO - Running setup.py install for psutil 08:43:30 INFO - building 'psutil._psutil_osx' extension 08:43:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:43:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:43:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:43:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:43:31 INFO - building 'psutil._psutil_posix' extension 08:43:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:43:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:43:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:43:31 INFO - ^ 08:43:31 INFO - 1 warning generated. 08:43:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:43:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:31 INFO - Successfully installed psutil 08:43:31 INFO - Cleaning up... 08:43:31 INFO - Return code: 0 08:43:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:43: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 mozsystemmonitor==0.3 08:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:31 INFO - 'HOME': '/Users/cltbld', 08:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:31 INFO - 'LOGNAME': 'cltbld', 08:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:31 INFO - 'MOZ_NO_REMOTE': '1', 08:43:31 INFO - 'NO_EM_RESTART': '1', 08:43:31 INFO - 'PAGER': '/bin/cat', 08:43:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:31 INFO - 'PWD': '/builds/slave/test', 08:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:31 INFO - 'SHELL': '/bin/bash', 08:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:31 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:31 INFO - 'USER': 'cltbld', 08:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:31 INFO - 'XPC_FLAGS': '0x0', 08:43:31 INFO - 'XPC_SERVICE_NAME': '0', 08:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:34 INFO - Installing collected packages: mozsystemmonitor 08:43:34 INFO - Running setup.py install for mozsystemmonitor 08:43:34 INFO - Successfully installed mozsystemmonitor 08:43:34 INFO - Cleaning up... 08:43:34 INFO - Return code: 0 08:43:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:34 INFO - 'HOME': '/Users/cltbld', 08:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:34 INFO - 'LOGNAME': 'cltbld', 08:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:34 INFO - 'MOZ_NO_REMOTE': '1', 08:43:34 INFO - 'NO_EM_RESTART': '1', 08:43:34 INFO - 'PAGER': '/bin/cat', 08:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:34 INFO - 'PWD': '/builds/slave/test', 08:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:34 INFO - 'SHELL': '/bin/bash', 08:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:34 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:34 INFO - 'USER': 'cltbld', 08:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:34 INFO - 'XPC_FLAGS': '0x0', 08:43:34 INFO - 'XPC_SERVICE_NAME': '0', 08:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:38 INFO - warning: no files found matching '*.txt' 08:43:38 INFO - no previously-included directories found matching 'build' 08:43:38 INFO - no previously-included directories found matching 'dist' 08:43:38 INFO - no previously-included directories found matching '.git*' 08:43:38 INFO - Installing collected packages: jsonschema, functools32 08:43:38 INFO - Running setup.py install for functools32 08:43:38 INFO - warning: no files found matching '*.txt' 08:43:38 INFO - no previously-included directories found matching 'build' 08:43:38 INFO - no previously-included directories found matching 'dist' 08:43:38 INFO - no previously-included directories found matching '.git*' 08:43:38 INFO - Successfully installed jsonschema functools32 08:43:38 INFO - Cleaning up... 08:43:38 INFO - Return code: 0 08:43:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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', '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 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:43: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 functools32==3.2.3-2 08:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:38 INFO - 'HOME': '/Users/cltbld', 08:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:38 INFO - 'LOGNAME': 'cltbld', 08:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:38 INFO - 'MOZ_NO_REMOTE': '1', 08:43:38 INFO - 'NO_EM_RESTART': '1', 08:43:38 INFO - 'PAGER': '/bin/cat', 08:43:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:38 INFO - 'PWD': '/builds/slave/test', 08:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:38 INFO - 'SHELL': '/bin/bash', 08:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:38 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:38 INFO - 'USER': 'cltbld', 08:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:38 INFO - 'XPC_FLAGS': '0x0', 08:43:38 INFO - 'XPC_SERVICE_NAME': '0', 08:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:43:38 INFO - Cleaning up... 08:43:38 INFO - Return code: 0 08:43:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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', '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 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:43: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 blobuploader==1.2.4 08:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:38 INFO - 'HOME': '/Users/cltbld', 08:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:38 INFO - 'LOGNAME': 'cltbld', 08:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:38 INFO - 'MOZ_NO_REMOTE': '1', 08:43:38 INFO - 'NO_EM_RESTART': '1', 08:43:38 INFO - 'PAGER': '/bin/cat', 08:43:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:38 INFO - 'PWD': '/builds/slave/test', 08:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:38 INFO - 'SHELL': '/bin/bash', 08:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:38 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:38 INFO - 'USER': 'cltbld', 08:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:38 INFO - 'XPC_FLAGS': '0x0', 08:43:38 INFO - 'XPC_SERVICE_NAME': '0', 08:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:41 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:42 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 08:43:42 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 08:43:42 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 08:43:42 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 08:43:42 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 08:43:42 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 08:43:42 INFO - Downloading docopt-0.6.1.tar.gz 08:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:42 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:42 INFO - Running setup.py install for blobuploader 08:43:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:42 INFO - Running setup.py install for requests 08:43:43 INFO - Running setup.py install for docopt 08:43:43 INFO - Successfully installed blobuploader requests docopt 08:43:43 INFO - Cleaning up... 08:43:43 INFO - Return code: 0 08:43:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:43 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 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43:43 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 08:43:43 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 08:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:43 INFO - 'HOME': '/Users/cltbld', 08:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:43 INFO - 'LOGNAME': 'cltbld', 08:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:43 INFO - 'MOZ_NO_REMOTE': '1', 08:43:43 INFO - 'NO_EM_RESTART': '1', 08:43:43 INFO - 'PAGER': '/bin/cat', 08:43:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:43 INFO - 'PWD': '/builds/slave/test', 08:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:43 INFO - 'SHELL': '/bin/bash', 08:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:43 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:43 INFO - 'USER': 'cltbld', 08:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:43 INFO - 'XPC_FLAGS': '0x0', 08:43:43 INFO - 'XPC_SERVICE_NAME': '0', 08:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:43 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Ql8ptb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-eNxiyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-BymCqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-QFIVgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dAJ_9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-243yvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-8jEUNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-i7aciu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-G9LNAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-jBomJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:44 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-cGGpwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:45 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-89o043-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:45 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-M3SGBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:45 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-YuqGyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:45 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-THyXH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:45 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dnO4vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:45 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-jmLWPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:45 INFO - Running setup.py install for manifestparser 08:43:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:46 INFO - Running setup.py install for mozcrash 08:43:46 INFO - Running setup.py install for mozdebug 08:43:46 INFO - Running setup.py install for mozdevice 08:43:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:46 INFO - Running setup.py install for mozfile 08:43:46 INFO - Running setup.py install for mozhttpd 08:43:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:46 INFO - Running setup.py install for mozinfo 08:43:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:46 INFO - Running setup.py install for mozInstall 08:43:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Running setup.py install for mozleak 08:43:47 INFO - Running setup.py install for mozlog 08:43:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Running setup.py install for moznetwork 08:43:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Running setup.py install for mozprocess 08:43:47 INFO - Running setup.py install for mozprofile 08:43:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:47 INFO - Running setup.py install for mozrunner 08:43:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:48 INFO - Running setup.py install for mozscreenshot 08:43:48 INFO - Running setup.py install for moztest 08:43:48 INFO - Running setup.py install for mozversion 08:43:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:48 INFO - Cleaning up... 08:43:48 INFO - Return code: 0 08:43:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:48 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')]} 08:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 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')]} 08:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 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 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43:48 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 08:43:48 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 08:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:48 INFO - 'HOME': '/Users/cltbld', 08:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:48 INFO - 'LOGNAME': 'cltbld', 08:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:48 INFO - 'MOZ_NO_REMOTE': '1', 08:43:48 INFO - 'NO_EM_RESTART': '1', 08:43:48 INFO - 'PAGER': '/bin/cat', 08:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:48 INFO - 'PWD': '/builds/slave/test', 08:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:48 INFO - 'SHELL': '/bin/bash', 08:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:48 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:48 INFO - 'USER': 'cltbld', 08:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:48 INFO - 'XPC_FLAGS': '0x0', 08:43:48 INFO - 'XPC_SERVICE_NAME': '0', 08:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:48 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-3JR932-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43: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)) 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:48 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-pxm15j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-KMX1UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-GUYZtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-nNSoja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-9j6W1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-nf7hNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-CIX1zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-jgonU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yyUAfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-mcrCE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:49 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)) 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:49 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-PRnniF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:50 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-oz0KNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:50 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)) 08:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:50 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-M65ouX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:50 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-MQ8Hcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:50 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)) 08:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:50 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-JCgt22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:50 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-_dY78u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:50 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)) 08:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:50 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)) 08:43:50 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:50 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:50 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 08:43:50 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 08:43:50 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 08:43:50 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 08:43:50 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 08:43:50 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 08:43:53 INFO - Downloading blessings-1.6.tar.gz 08:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:53 INFO - Installing collected packages: blessings 08:43:53 INFO - Running setup.py install for blessings 08:43:53 INFO - Successfully installed blessings 08:43:53 INFO - Cleaning up... 08:43:53 INFO - Return code: 0 08:43:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:53 INFO - Reading from file tmpfile_stdout 08:43:53 INFO - Current package versions: 08:43:53 INFO - blessings == 1.6 08:43:53 INFO - blobuploader == 1.2.4 08:43:53 INFO - docopt == 0.6.1 08:43:53 INFO - functools32 == 3.2.3-2 08:43:53 INFO - jsonschema == 2.5.1 08:43:53 INFO - manifestparser == 1.1 08:43:53 INFO - mozInstall == 1.12 08:43:53 INFO - mozcrash == 1.0 08:43:53 INFO - mozdebug == 0.1 08:43:53 INFO - mozdevice == 0.49 08:43:53 INFO - mozfile == 1.2 08:43:53 INFO - mozhttpd == 0.7 08:43:53 INFO - mozinfo == 0.9 08:43:53 INFO - mozleak == 0.1 08:43:53 INFO - mozlog == 3.4 08:43:53 INFO - moznetwork == 0.27 08:43:53 INFO - mozprocess == 0.24 08:43:53 INFO - mozprofile == 0.28 08:43:53 INFO - mozrunner == 6.13 08:43:53 INFO - mozscreenshot == 0.1 08:43:53 INFO - mozsystemmonitor == 0.3 08:43:53 INFO - moztest == 0.8 08:43:53 INFO - mozversion == 1.4 08:43:53 INFO - psutil == 3.1.1 08:43:53 INFO - requests == 1.2.3 08:43:53 INFO - wsgiref == 0.1.2 08:43:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:53 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')]} 08:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:53 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')]} 08:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:53 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 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43:53 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 08:43:53 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 08:43:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:53 INFO - 'HOME': '/Users/cltbld', 08:43:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:53 INFO - 'LOGNAME': 'cltbld', 08:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:53 INFO - 'MOZ_NO_REMOTE': '1', 08:43:53 INFO - 'NO_EM_RESTART': '1', 08:43:53 INFO - 'PAGER': '/bin/cat', 08:43:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:53 INFO - 'PWD': '/builds/slave/test', 08:43:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:53 INFO - 'SHELL': '/bin/bash', 08:43:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:53 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:53 INFO - 'USER': 'cltbld', 08:43:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:53 INFO - 'XPC_FLAGS': '0x0', 08:43:53 INFO - 'XPC_SERVICE_NAME': '0', 08:43:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 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)) 08:43:54 INFO - Cleaning up... 08:43:54 INFO - Return code: 0 08:43:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a01db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a020768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9419d77c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:43:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:43:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:43:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:54 INFO - 'HOME': '/Users/cltbld', 08:43:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:54 INFO - 'LOGNAME': 'cltbld', 08:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:54 INFO - 'MOZ_NO_REMOTE': '1', 08:43:54 INFO - 'NO_EM_RESTART': '1', 08:43:54 INFO - 'PAGER': '/bin/cat', 08:43:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:54 INFO - 'PWD': '/builds/slave/test', 08:43:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:54 INFO - 'SHELL': '/bin/bash', 08:43:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:43:54 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:43:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:54 INFO - 'USER': 'cltbld', 08:43:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:54 INFO - 'XPC_FLAGS': '0x0', 08:43:54 INFO - 'XPC_SERVICE_NAME': '0', 08:43:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:43:54 INFO - Cleaning up... 08:43:54 INFO - Return code: 0 08:43:54 INFO - Running post-action listener: _resource_record_post_action 08:43:54 INFO - Running post-action listener: _start_resource_monitoring 08:43:54 INFO - Starting resource monitoring. 08:43:54 INFO - [mozharness: 2017-01-16 16:43:54.418114Z] Finished create-virtualenv step (success) 08:43:54 INFO - [mozharness: 2017-01-16 16:43:54.419122Z] Running install step. 08:43:54 INFO - Running pre-action listener: _resource_record_pre_action 08:43:54 INFO - Running main action method: install 08:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:54 INFO - Reading from file tmpfile_stdout 08:43:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:54 INFO - Reading from file tmpfile_stdout 08:43:54 INFO - Output received: 08:43:54 INFO - Usage: mozinstall [options] installer 08:43:54 INFO - Options: 08:43:54 INFO - -h, --help show this help message and exit 08:43:54 INFO - -d DEST, --destination=DEST 08:43:54 INFO - Directory to install application into. [default: 08:43:54 INFO - "/builds/slave/test"] 08:43:54 INFO - --app=APP Application being installed. [default: firefox] 08:43:54 INFO - mkdir: /builds/slave/test/build/application 08:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:44:16 INFO - Reading from file tmpfile_stdout 08:44:16 INFO - Output received: 08:44:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:44:16 INFO - Running post-action listener: _resource_record_post_action 08:44:16 INFO - [mozharness: 2017-01-16 16:44:16.769835Z] Finished install step (success) 08:44:16 INFO - [mozharness: 2017-01-16 16:44:16.770004Z] Running run-tests step. 08:44:16 INFO - Running pre-action listener: _resource_record_pre_action 08:44:16 INFO - Running main action method: run_tests 08:44:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:44:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:44:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:44:16 INFO - 2017-01-16 08:44:16.784 screenresolution[1632:7546] starting screenresolution argv=screenresolution get 08:44:16 INFO - 2017-01-16 08:44:16.787 screenresolution[1632:7546] Display 0: 1600x1200x32@60 08:44:16 INFO - 2017-01-16 08:44:16.793 screenresolution[1633:7548] starting screenresolution argv=screenresolution list 08:44:16 INFO - Available Modes on Display 0 08:44:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:44:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:44:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:44:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:44:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:44:17 INFO - Intel Iris: 08:44:17 INFO - Chipset Model: Intel Iris 08:44:17 INFO - Type: GPU 08:44:17 INFO - Bus: Built-In 08:44:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:44:17 INFO - Vendor: Intel (0x8086) 08:44:17 INFO - Device ID: 0x0a2e 08:44:17 INFO - Revision ID: 0x0009 08:44:17 INFO - Displays: 08:44:17 INFO - Display: 08:44:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:44:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:44:17 INFO - Display Serial Number: 1600x1200 60 08:44:17 INFO - Main Display: Yes 08:44:17 INFO - Mirror: Off 08:44:17 INFO - Online: Yes 08:44:17 INFO - Rotation: Supported 08:44:17 INFO - Return code: 0 08:44:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:17 INFO - Python 2.7.3 08:44:17 INFO - Return code: 0 08:44:17 INFO - grabbing minidump binary from tooltool 08:44:17 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')]} 08:44:17 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/macosx64/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 0x109dfbd30>, '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 0x109d22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109df0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:44:17 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:44:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:44:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:17 INFO - Return code: 0 08:44:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:44:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:44:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 08:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --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 08:44:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.20vHCTAfjZ/Render', 08:44:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:17 INFO - 'HOME': '/Users/cltbld', 08:44:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:17 INFO - 'LOGNAME': 'cltbld', 08:44:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:17 INFO - 'MOZ_NO_REMOTE': '1', 08:44:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:17 INFO - 'NO_EM_RESTART': '1', 08:44:17 INFO - 'PAGER': '/bin/cat', 08:44:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:17 INFO - 'PWD': '/builds/slave/test', 08:44:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:17 INFO - 'SHELL': '/bin/bash', 08:44:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners', 08:44:17 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 08:44:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:17 INFO - 'USER': 'cltbld', 08:44:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:17 INFO - 'XPC_FLAGS': '0x0', 08:44:17 INFO - 'XPC_SERVICE_NAME': '0', 08:44:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 08:44:17 INFO - mozversion application_buildid: 20170116073621 08:44:17 INFO - mozversion application_changeset: d4d3a7b6d57e06891f158ccb4bebf507a8d55d32 08:44:17 INFO - mozversion application_display_name: Nightly 08:44:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:17 INFO - mozversion application_name: Firefox 08:44:17 INFO - mozversion application_remotingname: firefox 08:44:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:44:17 INFO - mozversion application_vendor: Mozilla 08:44:17 INFO - mozversion application_version: 53.0a1 08:44:17 INFO - mozversion platform_buildid: 20170116073621 08:44:17 INFO - mozversion platform_changeset: d4d3a7b6d57e06891f158ccb4bebf507a8d55d32 08:44:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:44:17 INFO - mozversion platform_version: 53.0a1 08:44:17 INFO - using testdate: 1484585057 08:44:17 INFO - actual date: 1484585057 08:44:17 INFO - starting webserver on 'localhost:49241' 08:44:17 INFO - SUITE-START | Running 2 tests 08:44:17 INFO - TEST-START | dromaeo_css 08:44:17 INFO - operating with platform_type : mac_ 08:44:17 INFO - Initialising browser for dromaeo_css test... 08:44:17 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpws0vgR/profile http://localhost:49241/getInfo.html) 08:44:19 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 08:44:19 INFO - PROCESS | 1643 | colorDepth:24 08:44:19 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 08:44:19 INFO - PROCESS | 1643 | __metrics 08:44:19 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:44:19 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:20 INFO - TEST-INFO | 1643: exit 0 08:44:20 INFO - Browser initialized. 08:44:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:20 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpws0vgR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:32 INFO - PROCESS | 1645 | RSS: Main: 235470848 08:44:32 INFO - PROCESS | 1645 | 08:47:35 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:47:38 INFO - PROCESS | 1645 | RSS: Main: 449204224 08:47:38 INFO - PROCESS | 1645 | 08:49:22 INFO - PROCESS | 1645 | ************************* 08:49:22 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 08:49:22 INFO - PROCESS | 1645 | 08:49:22 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:49:22 INFO - PROCESS | 1645 | Full stack: 08:49:22 INFO - PROCESS | 1645 | ************************* 08:50:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:50:41 INFO - PROCESS | 1645 | RSS: Main: 374542336 08:50:41 INFO - PROCESS | 1645 | 08:53:44 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:53:44 INFO - PROCESS | 1645 | RSS: Main: 352645120 08:53:44 INFO - PROCESS | 1645 | 08:56:47 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:56:47 INFO - PROCESS | 1645 | RSS: Main: 343687168 08:56:47 INFO - PROCESS | 1645 | 08:59:51 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:59:52 INFO - PROCESS | 1645 | RSS: Main: 339107840 08:59:52 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:02:55 INFO - PROCESS | 1645 | RSS: Main: 547577856 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | __start_tp_report 09:02:55 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 09:02:55 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 09:02:55 INFO - PROCESS | 1645 | |i|pagename|runs| 09:02:55 INFO - PROCESS | 1645 | |0;dojo.html;3339.4656854903214;3349.6482869298725;3358.076528954537;3372.9325413491747;3418.6923176914074;5564.693941833198;5645.435456454353;5648.915266271009;5712.771489140429;5729.512991395731;4737.763111844402;5707.942920570793;5776.971115144429;5792.247007888979;5853.707314634262;5108.182690769478;5130.769115389798;5137.357830271216;5183.922241166386;5215.478452154792;5284.471552844704;5325.866853328678;5326.041312563737;5328.20076988451;5367.490088441592;5108.872278193037;5265.631405801595;5305.965336759295;5308.362996440414;5327.573794096483;5133;5162.277281180638;5182.144946083891;5200.583953283728;5227.424983251839;5224.686518808846;5228.2680424740565;5231.712255825928;5249.580033597303;5281.788728450857;5707.885842283173;5731.512821410185;5731.942680573225;5739.598228124033;5755.453231942959;5064.215046667772;6109.321562077489;6142.170806941051;6287.96856015717;6304.401081897213;6198.318184999646;6239.126522286883;6314.621122732605;6331.398517140864;6363.300036995926;5793.102069179284;5849.122631605251;5851.590388672752;5876.6180198286975;5901.616394934315;6204.317525072239;6218.160548325918;6281.246250449975;6287.49700023997;6288.8427789304715;4642.605378542794;5362.168863826113;6023.608465449732;6107.886786452505;6130.601510901777;6187.381261873867;6200.348963358872;6206.10011548332;6213.906791398133;6213.937860621336;6167.691615419211;6215.34738852423;6278.591891527036;6288.591241569284;6293.685315734195;6309.589876658094;6313.842153946188;6325.05124231369;6334.968325158345;6344.984802431681;4926.48271931442;4962.578180854595;5031.874203144951;5041.2438134280155;5082.440931497532;4447.73313601185;4455.019895622958;4480.215962206601;4488.4165058542185;4537.410136682211;5898.056310990221;5898.911516327258;5903.2325797646035;5907.232059832194;5908.379620139824;6333.20834895638;6352.65060421672;6359.682015899187;6369.394907483782;6378;5667.008273552112;5743.167240750068;5748.425157484218;5791.594588378773;5794.797182098607;5446.972765136228;5448.700321482277;5454.963556924172;5455.1544510600925;5460.180972854104;6263.060540918898;6277.686115694289;6279.497640188865;6280.183576135073;6281.371862813865;6231.2834024086;6270.028145637433;6325.114483972339;6337.144485494399;6343.397377249154;6324.177856878577;6330.303666596763;6343.9682801585695;6356;6357;6033.939660603338;6102.368068311607;6263.467605253604;6265.404786545271;6278.529110316653;6230.59501132425;6248.843778905381;6259.78090766821;6264.185655864709;6274.247090349188;5952.196453478899;6093.756249750138;6099.9390006099375;6100.8779824404155;6123.14276001369;6048.576599637983;6067.696615169136;6078.179445774764;6084.939150608614;6100.420460056288;5937.762489500372;5941.554383421347;5954.225950626391;5984.461398474158;5988.401159884151;6127;6169.660668663087;6191.133241346305;6192.659403732838;6197.25632924052;5089.898202036013;5969.432903874125;5992.280926288873;6001.699915004319;6011.789587364421 09:02:55 INFO - PROCESS | 1645 | |1;ext.html;480.7812445337372;490.32825029709306;498.25262106839733;501.5636396335189;521.145321672457;37404.25191496172;39911.60088399119;39997.60002399975;42356;42490.7875460623;41086.79456602713;41449;41492.58507414925;41548.79225603875;41568.16863662725;8299.875501867476;9187.816243675139;9375.81248375032;9383.624655013791;9411.341206115574;6578.6381749003785;11035.83446248303;11291.040261577777;11337.26307789991;11501.367424791633;9556;11287.209895307331;11358.432078396088;11365.374904380256;11411.486483108238;7066.32869877366;8493.065762766091;11356.69398019226;11426.485808138612;11446.885531144666;10898.291611045257;11217.887821121765;11250;11352;11377.488013039432;39525.80237098825;39750.801245993585;39804;39838.20323593512;39853;4059.97970010151;4073.6130067643526;4099.651529619986;4100.17996400718;4101.651359634435;24362.512749744907;29840.55239171414;30418.54372184419;30630.38739225203;30754.53868191979;2751.463464624399;3157.9368412631848;3299.9175020624434;3311.2384151645256;3340.7828491148;314141;364815;366898.9999999973;367921;368123.159384204;54469.646597709594;61344;63047.054294185626;63202.367976320566;63424;64920.67539662271;64971;64995.35004649987;65087.674561627835;65285.020724689166;15667.216639167997;16033.599160021093;16248.918755406385;16277.104759238118;16291.918540407221;11071.557137714562;11350.602728904449;11634.301941883514;12519.43662535188;12599.18105323151;13441.731165376637;14368.353424095942;17610.735838962424;17629.854059486093;17665.646687066186;5989.401059893976;6007.339192688801;6947.756828511079;7062.364387205176;7109.324614161646;705.8059033765653;868.9391742578085;876.6668665907042;897.7845317123844;914.7559319325844;28626.71373286282;29862.25344366365;29887.402251955275;29902.551461728093;29971.29072132096;1050.4170185547096;1055.5883205549842;1081.2431298091367;1081.918856085781;1192.3263356203718;13356.799648005288;14714.705705885823;14963.476278330207;15477.690446191013;15760;617090.9145454334;623332;623555;626133;626525;58455.70772146112;58662.12006819901;58691;58832;59275;1375.5529452927838;1412.9505467308595;1440.0711541056169;1441.149721664223;1441.7765246386828;26551.734482654927;26711.93152273965;28330.150095497167;29204.968633625074;29760.851195743882;44289.77855110704;44339.33490997702;44391.556084438744;44430;44722;530775;535624;538336;539756;540137;39398.40902386409;40553.78338649845;40707.59292407038;42136.36795448009;44154;44866;45011.54988450074;46851.53148468472;48125.518744813504;48241.03517929552;39655.40516892307;39801;39876;40707.796461017504;41723;38667.80666096652;39901;40103;40442.39336410015;41658;38205.4269185968;38542.42186367151;38886;39038;39044.21911561696;31060.378792424475;34717.13207169841;35236.119097022776;35277;35501.289974199855;24436.389090272885;25619.743802561738;25784.097556585428;25818.741812581633;25855.612165817904 09:02:55 INFO - PROCESS | 1645 | |2;jquery.html;362.132692202176;385.94210868369726;389.51505375807125;392.192084306329;419.8320671731307;15362.69274614507;15364.69270614587;18225.817741822593;20817.687734683954;21078.262260820837;21846.672299915474;22103.557928841412;22547.323580292577;22709.432264193405;22784.65823012652;5655.688937108457;5704.942950570504;5835.9124613130625;5913.231279933602;5953.970230148843;4139.710220284582;5835.562332825055;5871.383504732005;5912.852178695524;5919.23050003499;4325.935110973338;6157.568970172089;6413.230412350525;6443.29123796382;6522.771702990396;6253.093301471306;6444.452221561173;6488.416042556169;6499.675016249169;6511.4465270452065;5667.291588551431;5732.31212254528;5733.283339582552;5739.598228124033;5743.023685973353;22031.559368812534;26091.608625870627;27066.32334191661;27105.121078205913;27381.86309068442;2730.4675588260297;2733.1390611957368;2751.257160566656;2755.8622068896675;2757.6690797104475;15182.62901888705;15484.612884677861;15536.300866461037;15866.52400427989;15990.76013859793;1782.7504149419092;1804.49474147239;1822.5808064145187;1838.2922574808795;1841.8526517878538;129620.35189823991;133111.33444332815;134411;135046.3247683765;136558;10415.270931034755;10969.012788849042;11351.772964540829;11494.88505114955;11619.908416484945;13314.267715275559;14874.256287185814;14915.105093694414;14917.104973701613;14919.179445130621;8337.666493340319;8503.872441913376;8665.696700615448;8721.127887211354;8787;8497.490150590984;8523.403361764616;8529.061803201643;8663.870041949376;8694.913050869536;6458.113041916937;6915.135608048994;7241.89137162943;7267.4549408794555;7279.235680253497;1901.4485799118102;1934.6711059119984;1937.6899696048847;1945.552522919708;1954.218312674913;1034.896510348959;1040.0015984654817;1053.536443964653;1078.094400703413;1098.4672433869566;17380.565485862953;21971.560568788536;22301;22532.887335563217;23045.654315185286;1065.7655315830505;1068.8396740488834;1088.6733979806027;1093.0763504838399;1104.4532956186738;9516.476593787409;11111.888811118984;11306.83039754388;11931.761364772656;11986;402812;733659;742184;759132;769371;105441;109087;141345;160111;167178.8051657146;1068.551208492435;1099.8680158381046;1131.4342828585707;1133.195431243826;1135.6536256441864;15668;18782.96693681806;20473.283435079702;20518.281860134823;20558.897205514477;48754.04983800608;61772;61939.380606193365;63948.68025659842;64153;90223.54888225517;90994.63508047252;91418.5429072877;92931;93217.2800127994;8344;8503;8523.786905327417;8554.101819309131;8601.870971935552;11503.827442588536;13359;13457.596272111852;13826.30868456553;13861.237631929936;11521.884781152416;11610;11757.764844702888;11835.408229588314;11995.1003674723;9076.455412675261;11330.660080197607;11467.598634047768;11648.94175529117;11762.70593235176;11514.596989105341;11542.59600913964;11876.940615296868;11962.820557691815;11994.940025299818;8271.95864020676;8501.447405918596;8530.44086773953;8535.615897284513;8567.828643427221;8778.473291602524;10031.54858031405;11471.254368466023;11497.597584084517;11754.177207595387 09:02:55 INFO - PROCESS | 1645 | |3;mootools.html;1278.2394475287203;1459.9708005839877;1466.7139907717997;1476.9113853168803;1485.7399955007877;7987.480813747103;8361.247487726103;8372.162783721633;8378.832423351529;8392.286655634278;7375.963120184391;7657.00458940337;7659.042619672541;7927;8171.346292296616;2288.0847660935633;2328.976710232893;2330.778576035274;2332.183735692511;2335.1085620647245;2298.000369839117;2312.491251924574;2340.0990618611786;2353.505763789606;2374.6556749271344;2018.5962807438498;2093.654546999743;2218.866867987918;2288.8855557222155;2297.21894555851;2274.6701728249395;2281.0989659084566;2282.269673704407;2285.6000199964938;2287.3709729824263;2230.408941630469;2279.0086312454137;2293.3005433342823;2334.7198336199594;2338.976610233893;8208.917910820875;8289.04675962266;8290.585470726439;8291.461055031403;8298.460600060977;4972.651914365996;5120.641555091145;5139.331886854722;5144.0740666679985;5147.150720131174;3026.515757478815;3279.540864279003;3441.2773317603333;3455.7926524408363;3510.80690562019;1157.5369852059243;1220.9572664956684;1248.1200753468784;1691.3995531586233;1726.6460375622967;10566.366018038942;10569.260151789378;10702.678919632424;10711.94644026775;10724.94637526823;3960;4473.46318441789;4629.305604159335;4687.414073240845;4700.365450664185;9190.03504632004;9287.117723816227;9399.671011514563;9415.105564971316;9420.19928306088;5225.738713064332;5229.294045303911;5231.607629427808;5233.476652334736;5241.842744717665;4255.851045213402;4386.934195987063;4468.151051300242;4706.129366067288;4736.289556566542;3792.3363411402893;3795.7153213509096;3915.4909861717792;3920.843166273317;3931.5282166139673;1257.3461799864203;1282.6985658370274;1285.5500574798932;1296.319432298051;1298.5519995601503;682.1064405628642;759.3811043999123;770.7148355108645;786.202004964961;814.4014149600039;5217.973910130425;5264.263003179558;5356.8660783479945;5452.318460192476;5551.2228288039705;552.1717423864204;569.792025910548;570.3070769015583;577.3822010448863;586.9236999190078;3525.7884526928465;3682.8710995115043;3713.1088538750505;3820.5797362290127;4055.8986025349013;9632.90367096334;9855.80288394228;9867.40795552269;9869.161121304625;9869.358491698016;9683.90316096844;9803.264755143393;9830.950845245728;9841.311108222499;9845.60617575289;7300.452466065067;7606.505577137468;7671.731489397845;7693.4999225051315;7787.221277872168;4971.900561988812;5155.9742201288755;5560.109493221166;5616.691081990366;5677.602567820378;8784.297256219616;8954.597043133204;9126.859142607174;9260.675876344296;9291.76770580741;8795.252403545514;9074.637014519345;9164.175224229852;9319.534023298673;9353;5577.776888924398;6785.660716964231;6824.044633751179;6843.794686159423;7115.928840711734;7509.1739908608915;7754.6898124074405;7780.572068536285;7841.921580784119;7855.685772569033;6665.266820649627;6757.054012438164;6790.898136528055;6810.693518791765;6891.517593768388;6936.375726184668;6978.127734033246;6982.581045137308;7008.264132266038;7025.929740702528;6159.322474527708;6179.3820617937845;6268.153799237045;6300.086487459201;6366.681665916778;4854.004928989478;4883.121038213156;4890.853274401631;4927.384076990376;5026.673266237683;4827.95172048275;4846.200376937766;4932.235503496964;4986.351774269322;4995.850124496271 09:02:55 INFO - PROCESS | 1645 | |4;prototype.html;351.41840254379;357.61020487668435;363.29883325182396;373.93643080676316;374.58421152520714;5248.343957005374;5295.496927791858;5328.360596728393;5361.490658387456;5432.375276843164;4065.3901914712733;4413.801378937947;5042.445331013586;5045.899082018357;5138.152204886199;3134.6081739782526;3520.9295814083703;3998.6404622428295;4017.0517299109906;4022.637962583367;3445.5865296164498;3487.4071407860597;4045.5347635022054;4076.2458945095254;4090.734102283342;3259.5925509311337;3854.094287842355;4044.170944956292;4049.838006479752;4059.330210515276;3844.2503711776353;3907.3943538751255;3967.74209676373;4021.4973128358956;4100.835966561334;3581.048328660886;3583.8208089595414;3591.5813253764877;3604.5133906922756;3623.5289412376223;4966;5005.324281222025;5021.372328458942;5029.547340739351;5030.698158110525;3786.5077539919907;3944.112574670705;4188.057687020427;4469.240229161051;4686.250199968023;4878.951025529493;5165.948340516585;5239.580833533346;5422.620416570841;5471.644343117724;3212.9357412851846;3721.8511259549587;3746.5129533160516;3756.9624303756887;3780.924381512382;4905.583025442842;5122.795088196468;5597.524210442118;5651.350094739158;5686.232358631614;3306.9338613228083;3758.379867321861;3779.7921114338974;3792.7913964732206;3816.4466152407745;3845.9230815383535;3850.0759817643566;3853.7302388832513;3853.8265778039495;3871.341871881787;4466.583063956076;4484.798184081724;4490.865274041784;4499.920019195435;4541.8183272669385;4656.278276867091;5258.815941442108;5528.899018372993;5537.529310008614;5659.886802263932;1232.48235740989;1233.821700276252;1234.6789834643057;1242.372601836067;1246.3145270101588;728.1044315491869;744.5272252119943;857.0829212742431;863.1799790199336;865.2861389353808;4513.751743654065;4760.049548469622;4801.959167353861;4879.804807807719;4894.776305923519;4705.905881882343;5193.5585475234275;5399.974004939049;5418.972905135449;5476.91784623231;4488.745659396911;4583.358329833826;4775.570198682066;4836.879078023077;4979.402471703419;2488.7760101590943;2583.457473930458;2778.5268414481898;2866.498362786504;2891.465078960399;5278.366596008504;5417.4311697272005;5687.8009269676195;5692.975264452355;5701.629394089371;4851.951480485221;5191.076970287953;5211.947880521222;5483.972580137074;5552.278203833475;4886.877828054327;5310.867228319245;5351.946480535223;5441.646292990943;5536.031194541019;5354.089804733283;5422.810201642924;5434.565234781129;5449.972750136224;5487.807926722546;4699.412573428322;5305.973470132624;5355.384130825005;5544.889102217852;5615.894039735099;4860.513948605111;5213.895722085613;5539.9169012464035;5575.498205161555;5832.445917637818;3462.5325581047246;3813.675837553728;3824.598417166269;3852.6725228355904;3971.8212680428874;4991.750412479289;5525.18982019647;5577.8047768327915;5606.85982850432;5611.971940140274;5265.631405801557;5372.247885296139;5472.972635136958;5487.338640759308;5487.722595122979;4556.453225612815;4690.507496712796;4902.803887844589;5286.889753151881;5505.256790333414;4773.63704966044;5334.306540149756;5377.704226267593;5380.273663055437;5395.217693434509;4575.40519732446;5333.866653333697;5441.809536666197;5448.727563621882;5456.945430545803;4720.989330843763;5348.983693098299;5350.277712508761;5369.731513424391;5423.156126916867 09:02:55 INFO - PROCESS | 1645 | |5;yui.html;710.8933659951003;748.2069006852734;768.581123287808;794.3010151067062;826.3389288569143;13591.796123058137;13619.931900340509;14911.552653420402;15743.448979285728;15844.366225350986;14393.640158996004;14469.421223151061;14556.272186390665;14571.489997850078;14578.562643120724;678.4572342126304;700.6426722371576;704.2710794327871;844.9070602233734;861.2378045429808;831.1729828820332;845.8646616541355;849.5497386385226;862.9309655227567;863.7581477186367;911.6854685133618;914.0996118822954;916.4547094478775;917.3853518142861;919.8068405634825;709.3438569323407;903.2142036428284;908.6047569307373;909.1363204955253;911.6535716427782;543.9755211015514;661.7055410342399;678.3284548297199;678.7556479667315;685.3831551603597;15339.309731062129;15358.769618455732;15387.615309617237;15397.53807385769;15429.382824687;13742;13852.584422467342;13878.236696981661;13915.512957046454;13917.30413479322;12337.50649974;12671.683207919783;12804.871951280555;12913.935430322883;13024.86975130246;4368.08154814049;4452.3989261449615;4488.079943611552;4555.63554915606;4654.581087702123;97616.51191744138;99303.0069699301;101114.85506884058;101736;102180.46729298992;10480.580776768844;10568.418736969386;10780.353178809297;10876.891231087588;11339.206255562032;21689.915504224726;21740.56518869614;22552.66171007436;22561.98471068806;22562.887185563966;7707.884381734279;7742.651580678883;7758.262965018314;7840.882386764203;7952.32405245549;4165.500139983222;4217.536071032184;4251.957480425218;4267.1892340455215;4408.515063343029;3487.89536313911;3536.1513236823494;3549.18368775178;3567.7680950738118;3580.964190358063;650.632392698124;653.7581094994787;655.131950166032;666.1939053745023;667.9599224046573;622.3745136138152;635.463033736492;642.8135840606171;645.2063961327593;648.42938214372;9848.458334791656;9852.359596626196;9946.552405141785;9954.502274886372;10000.999900010087;624.6064979063161;625.2309659119309;657.2844874876569;657.6777379084215;657.9769708060195;4428.778561071934;4814.927776083362;4816.397263139061;4818.759062046954;4876.195427754452;97436;98201;110881;111031.88968110216;112478.87521124848;91173;93774;93799;95673;97441.51279243559;61449.69275153685;77233;78805.60597197092;81232.59383703044;81345.59327203444;8909.420887642282;9307.674231401868;9350.971393146885;9411.058894110807;9519.238460923249;47601;47736;48506;48809;52649.736751316;58086.41913580979;63200.367996321285;64528;70661.64669176827;71609.92585111332;12874.420651070912;12904.870951290366;13254.072214944861;13381.264030478416;13763.105398149088;14531.564053078424;14815.92592037076;14902.701945960804;15054.096754194783;15171;13698.931505342409;13910.930445347709;13945.16329020262;14130.293485325898;14389.784153237919;13561.168153088931;13892.93053534726;14025.509107181608;14057.886586901848;14174.220417876702;11876.76246475083;13511.729765404834;13714.451421943011;14133.434662613381;14201.431942722176;10970.780584388427;11036.889631103586;11190.659545398088;11384.658460246206;11673.299602023906;9129.634814607341;9302.255819534555;9957.950210249192;10485.528151233366;10759.731006724895 09:02:55 INFO - PROCESS | 1645 | __end_tp_report 09:02:55 INFO - PROCESS | 1645 | __start_cc_report 09:02:55 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2324 09:02:55 INFO - PROCESS | 1645 | __end_cc_report 09:02:55 INFO - PROCESS | 1645 | __startTimestamp1484586175465__endTimestamp 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | ------- Summary: start ------- 09:02:55 INFO - PROCESS | 1645 | Number of tests: 6 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5749.59 Median:5954.23 stddev:649.59 (10.9%) stddev-sans-first:623.46 09:02:55 INFO - PROCESS | 1645 | Values: 3339.5 3349.6 3358.1 3372.9 3418.7 5564.7 5645.4 5648.9 5712.8 5729.5 4737.8 5707.9 5777.0 5792.2 5853.7 5108.2 5130.8 5137.4 5183.9 5215.5 5284.5 5325.9 5326.0 5328.2 5367.5 5108.9 5265.6 5306.0 5308.4 5327.6 5133.0 5162.3 5182.1 5200.6 5227.4 5224.7 5228.3 5231.7 5249.6 5281.8 5707.9 5731.5 5731.9 5739.6 5755.5 5064.2 6109.3 6142.2 6288.0 6304.4 6198.3 6239.1 6314.6 6331.4 6363.3 5793.1 5849.1 5851.6 5876.6 5901.6 6204.3 6218.2 6281.2 6287.5 6288.8 4642.6 5362.2 6023.6 6107.9 6130.6 6187.4 6200.3 6206.1 6213.9 6213.9 6167.7 6215.3 6278.6 6288.6 6293.7 6309.6 6313.8 6325.1 6335.0 6345.0 4926.5 4962.6 5031.9 5041.2 5082.4 4447.7 4455.0 4480.2 4488.4 4537.4 5898.1 5898.9 5903.2 5907.2 5908.4 6333.2 6352.7 6359.7 6369.4 6378.0 5667.0 5743.2 5748.4 5791.6 5794.8 5447.0 5448.7 5455.0 5455.2 5460.2 6263.1 6277.7 6279.5 6280.2 6281.4 6231.3 6270.0 6325.1 6337.1 6343.4 6324.2 6330.3 6344.0 6356.0 6357.0 6033.9 6102.4 6263.5 6265.4 6278.5 6230.6 6248.8 6259.8 6264.2 6274.2 5952.2 6093.8 6099.9 6100.9 6123.1 6048.6 6067.7 6078.2 6084.9 6100.4 5937.8 5941.6 5954.2 5984.5 5988.4 6127.0 6169.7 6191.1 6192.7 6197.3 5089.9 5969.4 5992.3 6001.7 6011.8 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:65278.81 Median:39703.10 stddev:138198.70 (348.1%) stddev-sans-first:138500.75 09:02:55 INFO - PROCESS | 1645 | Values: 480.8 490.3 498.3 501.6 521.1 37404.3 39911.6 39997.6 42356.0 42490.8 41086.8 41449.0 41492.6 41548.8 41568.2 8299.9 9187.8 9375.8 9383.6 9411.3 6578.6 11035.8 11291.0 11337.3 11501.4 9556.0 11287.2 11358.4 11365.4 11411.5 7066.3 8493.1 11356.7 11426.5 11446.9 10898.3 11217.9 11250.0 11352.0 11377.5 39525.8 39750.8 39804.0 39838.2 39853.0 4060.0 4073.6 4099.7 4100.2 4101.7 24362.5 29840.6 30418.5 30630.4 30754.5 2751.5 3157.9 3299.9 3311.2 3340.8 314141.0 364815.0 366899.0 367921.0 368123.2 54469.6 61344.0 63047.1 63202.4 63424.0 64920.7 64971.0 64995.4 65087.7 65285.0 15667.2 16033.6 16248.9 16277.1 16291.9 11071.6 11350.6 11634.3 12519.4 12599.2 13441.7 14368.4 17610.7 17629.9 17665.6 5989.4 6007.3 6947.8 7062.4 7109.3 705.8 868.9 876.7 897.8 914.8 28626.7 29862.3 29887.4 29902.6 29971.3 1050.4 1055.6 1081.2 1081.9 1192.3 13356.8 14714.7 14963.5 15477.7 15760.0 617090.9 623332.0 623555.0 626133.0 626525.0 58455.7 58662.1 58691.0 58832.0 59275.0 1375.6 1413.0 1440.1 1441.1 1441.8 26551.7 26711.9 28330.2 29205.0 29760.9 44289.8 44339.3 44391.6 44430.0 44722.0 530775.0 535624.0 538336.0 539756.0 540137.0 39398.4 40553.8 40707.6 42136.4 44154.0 44866.0 45011.5 46851.5 48125.5 48241.0 39655.4 39801.0 39876.0 40707.8 41723.0 38667.8 39901.0 40103.0 40442.4 41658.0 38205.4 38542.4 38886.0 39038.0 39044.2 31060.4 34717.1 35236.1 35277.0 35501.3 24436.4 25619.7 25784.1 25818.7 25855.6 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:38963.82 Median:22067.56 stddev:116131.95 (526.3%) stddev-sans-first:116421.56 09:02:55 INFO - PROCESS | 1645 | Values: 362.1 385.9 389.5 392.2 419.8 15362.7 15364.7 18225.8 20817.7 21078.3 21846.7 22103.6 22547.3 22709.4 22784.7 5655.7 5704.9 5835.9 5913.2 5954.0 4139.7 5835.6 5871.4 5912.9 5919.2 4325.9 6157.6 6413.2 6443.3 6522.8 6253.1 6444.5 6488.4 6499.7 6511.4 5667.3 5732.3 5733.3 5739.6 5743.0 22031.6 26091.6 27066.3 27105.1 27381.9 2730.5 2733.1 2751.3 2755.9 2757.7 15182.6 15484.6 15536.3 15866.5 15990.8 1782.8 1804.5 1822.6 1838.3 1841.9 129620.4 133111.3 134411.0 135046.3 136558.0 10415.3 10969.0 11351.8 11494.9 11619.9 13314.3 14874.3 14915.1 14917.1 14919.2 8337.7 8503.9 8665.7 8721.1 8787.0 8497.5 8523.4 8529.1 8663.9 8694.9 6458.1 6915.1 7241.9 7267.5 7279.2 1901.4 1934.7 1937.7 1945.6 1954.2 1034.9 1040.0 1053.5 1078.1 1098.5 17380.6 21971.6 22301.0 22532.9 23045.7 1065.8 1068.8 1088.7 1093.1 1104.5 9516.5 11111.9 11306.8 11931.8 11986.0 402812.0 733659.0 742184.0 759132.0 769371.0 105441.0 109087.0 141345.0 160111.0 167178.8 1068.6 1099.9 1131.4 1133.2 1135.7 15668.0 18783.0 20473.3 20518.3 20558.9 48754.0 61772.0 61939.4 63948.7 64153.0 90223.5 90994.6 91418.5 92931.0 93217.3 8344.0 8503.0 8523.8 8554.1 8601.9 11503.8 13359.0 13457.6 13826.3 13861.2 11521.9 11610.0 11757.8 11835.4 11995.1 9076.5 11330.7 11467.6 11648.9 11762.7 11514.6 11542.6 11876.9 11962.8 11994.9 8272.0 8501.4 8530.4 8535.6 8567.8 8778.5 10031.5 11471.3 11497.6 11754.2 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5332.75 Median:5232.54 stddev:2909.87 (55.6%) stddev-sans-first:2902.07 09:02:55 INFO - PROCESS | 1645 | Values: 1278.2 1460.0 1466.7 1476.9 1485.7 7987.5 8361.2 8372.2 8378.8 8392.3 7376.0 7657.0 7659.0 7927.0 8171.3 2288.1 2329.0 2330.8 2332.2 2335.1 2298.0 2312.5 2340.1 2353.5 2374.7 2018.6 2093.7 2218.9 2288.9 2297.2 2274.7 2281.1 2282.3 2285.6 2287.4 2230.4 2279.0 2293.3 2334.7 2339.0 8208.9 8289.0 8290.6 8291.5 8298.5 4972.7 5120.6 5139.3 5144.1 5147.2 3026.5 3279.5 3441.3 3455.8 3510.8 1157.5 1221.0 1248.1 1691.4 1726.6 10566.4 10569.3 10702.7 10711.9 10724.9 3960.0 4473.5 4629.3 4687.4 4700.4 9190.0 9287.1 9399.7 9415.1 9420.2 5225.7 5229.3 5231.6 5233.5 5241.8 4255.9 4386.9 4468.2 4706.1 4736.3 3792.3 3795.7 3915.5 3920.8 3931.5 1257.3 1282.7 1285.6 1296.3 1298.6 682.1 759.4 770.7 786.2 814.4 5218.0 5264.3 5356.9 5452.3 5551.2 552.2 569.8 570.3 577.4 586.9 3525.8 3682.9 3713.1 3820.6 4055.9 9632.9 9855.8 9867.4 9869.2 9869.4 9683.9 9803.3 9831.0 9841.3 9845.6 7300.5 7606.5 7671.7 7693.5 7787.2 4971.9 5156.0 5560.1 5616.7 5677.6 8784.3 8954.6 9126.9 9260.7 9291.8 8795.3 9074.6 9164.2 9319.5 9353.0 5577.8 6785.7 6824.0 6843.8 7115.9 7509.2 7754.7 7780.6 7841.9 7855.7 6665.3 6757.1 6790.9 6810.7 6891.5 6936.4 6978.1 6982.6 7008.3 7025.9 6159.3 6179.4 6268.2 6300.1 6366.7 4854.0 4883.1 4890.9 4927.4 5026.7 4828.0 4846.2 4932.2 4986.4 4995.9 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4374.01 Median:4883.34 stddev:1325.59 (27.1%) stddev-sans-first:1294.46 09:02:55 INFO - PROCESS | 1645 | Values: 351.4 357.6 363.3 373.9 374.6 5248.3 5295.5 5328.4 5361.5 5432.4 4065.4 4413.8 5042.4 5045.9 5138.2 3134.6 3520.9 3998.6 4017.1 4022.6 3445.6 3487.4 4045.5 4076.2 4090.7 3259.6 3854.1 4044.2 4049.8 4059.3 3844.3 3907.4 3967.7 4021.5 4100.8 3581.0 3583.8 3591.6 3604.5 3623.5 4966.0 5005.3 5021.4 5029.5 5030.7 3786.5 3944.1 4188.1 4469.2 4686.3 4879.0 5165.9 5239.6 5422.6 5471.6 3212.9 3721.9 3746.5 3757.0 3780.9 4905.6 5122.8 5597.5 5651.4 5686.2 3306.9 3758.4 3779.8 3792.8 3816.4 3845.9 3850.1 3853.7 3853.8 3871.3 4466.6 4484.8 4490.9 4499.9 4541.8 4656.3 5258.8 5528.9 5537.5 5659.9 1232.5 1233.8 1234.7 1242.4 1246.3 728.1 744.5 857.1 863.2 865.3 4513.8 4760.0 4802.0 4879.8 4894.8 4705.9 5193.6 5400.0 5419.0 5476.9 4488.7 4583.4 4775.6 4836.9 4979.4 2488.8 2583.5 2778.5 2866.5 2891.5 5278.4 5417.4 5687.8 5693.0 5701.6 4852.0 5191.1 5211.9 5484.0 5552.3 4886.9 5310.9 5351.9 5441.6 5536.0 5354.1 5422.8 5434.6 5450.0 5487.8 4699.4 5306.0 5355.4 5544.9 5615.9 4860.5 5213.9 5539.9 5575.5 5832.4 3462.5 3813.7 3824.6 3852.7 3971.8 4991.8 5525.2 5577.8 5606.9 5612.0 5265.6 5372.2 5473.0 5487.3 5487.7 4556.5 4690.5 4902.8 5286.9 5505.3 4773.6 5334.3 5377.7 5380.3 5395.2 4575.4 5333.9 5441.8 5448.7 5456.9 4721.0 5349.0 5350.3 5369.7 5423.2 09:02:55 INFO - PROCESS | 1645 | 09:02:55 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20481.39 Median:47668.50 stddev:29378.54 (61.6%) stddev-sans-first:29423.45 09:02:55 INFO - PROCESS | 1645 | Values: 710.9 748.2 768.6 794.3 826.3 13591.8 13619.9 14911.6 15743.4 15844.4 14393.6 14469.4 14556.3 14571.5 14578.6 678.5 700.6 704.3 844.9 861.2 831.2 845.9 849.5 862.9 863.8 911.7 914.1 916.5 917.4 919.8 709.3 903.2 908.6 909.1 911.7 544.0 661.7 678.3 678.8 685.4 15339.3 15358.8 15387.6 15397.5 15429.4 13742.0 13852.6 13878.2 13915.5 13917.3 12337.5 12671.7 12804.9 12913.9 13024.9 4368.1 4452.4 4488.1 4555.6 4654.6 97616.5 99303.0 101114.9 101736.0 102180.5 10480.6 10568.4 10780.4 10876.9 11339.2 21689.9 21740.6 22552.7 22562.0 22562.9 7707.9 7742.7 7758.3 7840.9 7952.3 4165.5 4217.5 4252.0 4267.2 4408.5 3487.9 3536.2 3549.2 3567.8 3581.0 650.6 653.8 655.1 666.2 668.0 622.4 635.5 642.8 645.2 648.4 9848.5 9852.4 9946.6 9954.5 10001.0 624.6 625.2 657.3 657.7 658.0 4428.8 4814.9 4816.4 4818.8 4876.2 97436.0 98201.0 110881.0 111031.9 112478.9 91173.0 93774.0 93799.0 95673.0 97441.5 61449.7 77233.0 78805.6 81232.6 81345.6 8909.4 9307.7 9351.0 9411.1 9519.2 47601.0 47736.0 48506.0 48809.0 52649.7 58086.4 63200.4 64528.0 70661.6 71609.9 12874.4 12904.9 13254.1 13381.3 13763.1 14531.6 14815.9 14902.7 15054.1 15171.0 13698.9 13910.9 13945.2 14130.3 14389.8 13561.2 13892.9 14025.5 14057.9 14174.2 11876.8 13511.7 13714.5 14133.4 14201.4 10970.8 11036.9 11190.7 11384.7 11673.3 9129.6 9302.3 9958.0 10485.5 10759.7 09:02:55 INFO - PROCESS | 1645 | -------- Summary: end -------- 09:02:55 INFO - PROCESS | 1645 | 09:02:56 INFO - TEST-INFO | 1645: exit 0 09:02:56 INFO - TEST-OK | dromaeo_css | took 1118796ms 09:02:56 INFO - TEST-START | kraken 09:02:56 INFO - operating with platform_type : mac_ 09:02:56 INFO - Initialising browser for kraken test... 09:02:56 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpqW_11T/profile http://localhost:49241/getInfo.html) 09:02:58 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 09:02:58 INFO - PROCESS | 1651 | colorDepth:24 09:02:58 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 09:02:58 INFO - PROCESS | 1651 | __metrics 09:02:58 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:02:58 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:59 INFO - TEST-INFO | 1651: exit 0 09:02:59 INFO - Browser initialized. 09:02:59 INFO - Running cycle 1/1 for kraken test... 09:02:59 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpqW_11T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:11 INFO - PROCESS | 1652 | RSS: Main: 235814912 09:03:11 INFO - PROCESS | 1652 | 09:03:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:15 INFO - PROCESS | 1652 | RSS: Main: 288047104 09:03:15 INFO - PROCESS | 1652 | 09:03:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:03:18 INFO - PROCESS | 1652 | RSS: Main: 288325632 09:03:18 INFO - PROCESS | 1652 | 09:03:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:03:22 INFO - PROCESS | 1652 | RSS: Main: 380153856 09:03:22 INFO - PROCESS | 1652 | 09:03:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:03:25 INFO - PROCESS | 1652 | RSS: Main: 281989120 09:03:25 INFO - PROCESS | 1652 | 09:03:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:27 INFO - PROCESS | 1652 | RSS: Main: 285597696 09:03:27 INFO - PROCESS | 1652 | 09:03:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:31 INFO - PROCESS | 1652 | RSS: Main: 327061504 09:03:31 INFO - PROCESS | 1652 | 09:03:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:34 INFO - PROCESS | 1652 | RSS: Main: 330817536 09:03:34 INFO - PROCESS | 1652 | 09:03:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:03:38 INFO - PROCESS | 1652 | RSS: Main: 327413760 09:03:38 INFO - PROCESS | 1652 | 09:03:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:40 INFO - PROCESS | 1652 | RSS: Main: 304238592 09:03:40 INFO - PROCESS | 1652 | 09:03:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:43 INFO - PROCESS | 1652 | RSS: Main: 307916800 09:03:43 INFO - PROCESS | 1652 | 09:03:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:45 INFO - PROCESS | 1652 | RSS: Main: 309915648 09:03:45 INFO - PROCESS | 1652 | 09:03:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:49 INFO - PROCESS | 1652 | RSS: Main: 327045120 09:03:49 INFO - PROCESS | 1652 | 09:03:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:53 INFO - PROCESS | 1652 | RSS: Main: 320761856 09:03:53 INFO - PROCESS | 1652 | 09:03:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:03:55 INFO - PROCESS | 1652 | RSS: Main: 365010944 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | __start_tp_report 09:03:55 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 09:03:55 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 09:03:55 INFO - PROCESS | 1652 | |i|pagename|runs| 09:03:55 INFO - PROCESS | 1652 | |0;ai-astar;114;113;113;113;113;113;114;113;113;113 09:03:55 INFO - PROCESS | 1652 | |1;audio-beat-detection;147;111;108;170;113;112;112;126;127;141 09:03:55 INFO - PROCESS | 1652 | |2;audio-dft;186;181;184;183;184;180;182;187;182;182 09:03:55 INFO - PROCESS | 1652 | |3;audio-fft;79;59;58;86;49;74;82;81;98;57 09:03:55 INFO - PROCESS | 1652 | |4;audio-oscillator;90;71;86;70;68;70;81;68;70;83 09:03:55 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;89;86;89;87;88;85;90;86;88;86 09:03:55 INFO - PROCESS | 1652 | |6;imaging-darkroom;96;95;95;96;96;96;96;96;96;97 09:03:55 INFO - PROCESS | 1652 | |7;imaging-desaturate;89;86;85;108;131;130;85;85;104;116 09:03:55 INFO - PROCESS | 1652 | |8;json-parse-financial;58;56;57;57;57;57;58;58;58;58 09:03:55 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;66;76;70;78;73;70;70;71;71;71 09:03:55 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;88;86;88;86;86;93;107;108;87;92 09:03:55 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;141;139;142;141;138;139;141;141;177;151 09:03:55 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;178;239;195;173;173;173;172;175;177;234 09:03:55 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;69;68;68;68;69;68;67;67;67;66 09:03:55 INFO - PROCESS | 1652 | __end_tp_report 09:03:55 INFO - PROCESS | 1652 | __start_cc_report 09:03:55 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1948 09:03:55 INFO - PROCESS | 1652 | __end_cc_report 09:03:55 INFO - PROCESS | 1652 | __startTimestamp1484586235241__endTimestamp 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | ------- Summary: start ------- 09:03:55 INFO - PROCESS | 1652 | Number of tests: 14 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:03:55 INFO - PROCESS | 1652 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:126.50 stddev:20.30 (16.0%) stddev-sans-first:20.16 09:03:55 INFO - PROCESS | 1652 | Values: 147.0 111.0 108.0 170.0 113.0 112.0 112.0 126.0 127.0 141.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:2.18 (1.2%) stddev-sans-first:2.05 09:03:55 INFO - PROCESS | 1652 | Values: 186.0 181.0 184.0 183.0 184.0 180.0 182.0 187.0 182.0 182.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:72.30 Median:80.00 stddev:15.72 (19.7%) stddev-sans-first:16.49 09:03:55 INFO - PROCESS | 1652 | Values: 79.0 59.0 58.0 86.0 49.0 74.0 82.0 81.0 98.0 57.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:8.37 (11.0%) stddev-sans-first:7.10 09:03:55 INFO - PROCESS | 1652 | Values: 90.0 71.0 86.0 70.0 68.0 70.0 81.0 68.0 70.0 83.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.65 (1.9%) stddev-sans-first:1.64 09:03:55 INFO - PROCESS | 1652 | Values: 89.0 86.0 89.0 87.0 88.0 85.0 90.0 86.0 88.0 86.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:03:55 INFO - PROCESS | 1652 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:85.00 stddev:18.72 (22.0%) stddev-sans-first:19.26 09:03:55 INFO - PROCESS | 1652 | Values: 89.0 86.0 85.0 108.0 131.0 130.0 85.0 85.0 104.0 116.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 09:03:55 INFO - PROCESS | 1652 | Values: 58.0 56.0 57.0 57.0 57.0 57.0 58.0 58.0 58.0 58.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:3.37 (4.8%) stddev-sans-first:2.91 09:03:55 INFO - PROCESS | 1652 | Values: 66.0 76.0 70.0 78.0 73.0 70.0 70.0 71.0 71.0 71.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:87.50 stddev:8.48 (9.7%) stddev-sans-first:8.86 09:03:55 INFO - PROCESS | 1652 | Values: 88.0 86.0 88.0 86.0 86.0 93.0 107.0 108.0 87.0 92.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:141.00 stddev:11.80 (8.4%) stddev-sans-first:12.43 09:03:55 INFO - PROCESS | 1652 | Values: 141.0 139.0 142.0 141.0 138.0 139.0 141.0 141.0 177.0 151.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.90 Median:177.50 stddev:25.99 (14.6%) stddev-sans-first:27.26 09:03:55 INFO - PROCESS | 1652 | Values: 178.0 239.0 195.0 173.0 173.0 173.0 172.0 175.0 177.0 234.0 09:03:55 INFO - PROCESS | 1652 | 09:03:55 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:0.88 09:03:55 INFO - PROCESS | 1652 | Values: 69.0 68.0 68.0 68.0 69.0 68.0 67.0 67.0 67.0 66.0 09:03:55 INFO - PROCESS | 1652 | -------- Summary: end -------- 09:03:55 INFO - PROCESS | 1652 | 09:03:56 INFO - TEST-INFO | 1652: exit 0 09:03:56 INFO - TEST-OK | kraken | took 60006ms 09:03:56 INFO - SUITE-END | took 1178s 09:03:56 INFO - Completed test suite (00:19:39) 09:03:56 INFO - javascript benchmark 09:03:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.4656854903214, 3349.6482869298725, 3358.076528954537, 3372.9325413491747, 3418.6923176914074, 5564.693941833198, 5645.435456454353, 5648.915266271009, 5712.771489140429, 5729.512991395731, 4737.763111844402, 5707.942920570793, 5776.971115144429, 5792.247007888979, 5853.707314634262, 5108.182690769478, 5130.769115389798, 5137.357830271216, 5183.922241166386, 5215.478452154792, 5284.471552844704, 5325.866853328678, 5326.041312563737, 5328.20076988451, 5367.490088441592, 5108.872278193037, 5265.631405801595, 5305.965336759295, 5308.362996440414, 5327.573794096483, 5133.0, 5162.277281180638, 5182.144946083891, 5200.583953283728, 5227.424983251839, 5224.686518808846, 5228.2680424740565, 5231.712255825928, 5249.580033597303, 5281.788728450857, 5707.885842283173, 5731.512821410185, 5731.942680573225, 5739.598228124033, 5755.453231942959, 5064.215046667772, 6109.321562077489, 6142.170806941051, 6287.96856015717, 6304.401081897213, 6198.318184999646, 6239.126522286883, 6314.621122732605, 6331.398517140864, 6363.300036995926, 5793.102069179284, 5849.122631605251, 5851.590388672752, 5876.6180198286975, 5901.616394934315, 6204.317525072239, 6218.160548325918, 6281.246250449975, 6287.49700023997, 6288.8427789304715, 4642.605378542794, 5362.168863826113, 6023.608465449732, 6107.886786452505, 6130.601510901777, 6187.381261873867, 6200.348963358872, 6206.10011548332, 6213.906791398133, 6213.937860621336, 6167.691615419211, 6215.34738852423, 6278.591891527036, 6288.591241569284, 6293.685315734195, 6309.589876658094, 6313.842153946188, 6325.05124231369, 6334.968325158345, 6344.984802431681, 4926.48271931442, 4962.578180854595, 5031.874203144951, 5041.2438134280155, 5082.440931497532, 4447.73313601185, 4455.019895622958, 4480.215962206601, 4488.4165058542185, 4537.410136682211, 5898.056310990221, 5898.911516327258, 5903.2325797646035, 5907.232059832194, 5908.379620139824, 6333.20834895638, 6352.65060421672, 6359.682015899187, 6369.394907483782, 6378.0, 5667.008273552112, 5743.167240750068, 5748.425157484218, 5791.594588378773, 5794.797182098607, 5446.972765136228, 5448.700321482277, 5454.963556924172, 5455.1544510600925, 5460.180972854104, 6263.060540918898, 6277.686115694289, 6279.497640188865, 6280.183576135073, 6281.371862813865, 6231.2834024086, 6270.028145637433, 6325.114483972339, 6337.144485494399, 6343.397377249154, 6324.177856878577, 6330.303666596763, 6343.9682801585695, 6356.0, 6357.0, 6033.939660603338, 6102.368068311607, 6263.467605253604, 6265.404786545271, 6278.529110316653, 6230.59501132425, 6248.843778905381, 6259.78090766821, 6264.185655864709, 6274.247090349188, 5952.196453478899, 6093.756249750138, 6099.9390006099375, 6100.8779824404155, 6123.14276001369, 6048.576599637983, 6067.696615169136, 6078.179445774764, 6084.939150608614, 6100.420460056288, 5937.762489500372, 5941.554383421347, 5954.225950626391, 5984.461398474158, 5988.401159884151, 6127.0, 6169.660668663087, 6191.133241346305, 6192.659403732838, 6197.25632924052, 5089.898202036013, 5969.432903874125, 5992.280926288873, 6001.699915004319, 6011.789587364421], "value": 5708.988992601349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.7812445337372, 490.32825029709306, 498.25262106839733, 501.5636396335189, 521.145321672457, 37404.25191496172, 39911.60088399119, 39997.60002399975, 42356.0, 42490.7875460623, 41086.79456602713, 41449.0, 41492.58507414925, 41548.79225603875, 41568.16863662725, 8299.875501867476, 9187.816243675139, 9375.81248375032, 9383.624655013791, 9411.341206115574, 6578.6381749003785, 11035.83446248303, 11291.040261577777, 11337.26307789991, 11501.367424791633, 9556.0, 11287.209895307331, 11358.432078396088, 11365.374904380256, 11411.486483108238, 7066.32869877366, 8493.065762766091, 11356.69398019226, 11426.485808138612, 11446.885531144666, 10898.291611045257, 11217.887821121765, 11250.0, 11352.0, 11377.488013039432, 39525.80237098825, 39750.801245993585, 39804.0, 39838.20323593512, 39853.0, 4059.97970010151, 4073.6130067643526, 4099.651529619986, 4100.17996400718, 4101.651359634435, 24362.512749744907, 29840.55239171414, 30418.54372184419, 30630.38739225203, 30754.53868191979, 2751.463464624399, 3157.9368412631848, 3299.9175020624434, 3311.2384151645256, 3340.7828491148, 314141.0, 364815.0, 366898.9999999973, 367921.0, 368123.159384204, 54469.646597709594, 61344.0, 63047.054294185626, 63202.367976320566, 63424.0, 64920.67539662271, 64971.0, 64995.35004649987, 65087.674561627835, 65285.020724689166, 15667.216639167997, 16033.599160021093, 16248.918755406385, 16277.104759238118, 16291.918540407221, 11071.557137714562, 11350.602728904449, 11634.301941883514, 12519.43662535188, 12599.18105323151, 13441.731165376637, 14368.353424095942, 17610.735838962424, 17629.854059486093, 17665.646687066186, 5989.401059893976, 6007.339192688801, 6947.756828511079, 7062.364387205176, 7109.324614161646, 705.8059033765653, 868.9391742578085, 876.6668665907042, 897.7845317123844, 914.7559319325844, 28626.71373286282, 29862.25344366365, 29887.402251955275, 29902.551461728093, 29971.29072132096, 1050.4170185547096, 1055.5883205549842, 1081.2431298091367, 1081.918856085781, 1192.3263356203718, 13356.799648005288, 14714.705705885823, 14963.476278330207, 15477.690446191013, 15760.0, 617090.9145454334, 623332.0, 623555.0, 626133.0, 626525.0, 58455.70772146112, 58662.12006819901, 58691.0, 58832.0, 59275.0, 1375.5529452927838, 1412.9505467308595, 1440.0711541056169, 1441.149721664223, 1441.7765246386828, 26551.734482654927, 26711.93152273965, 28330.150095497167, 29204.968633625074, 29760.851195743882, 44289.77855110704, 44339.33490997702, 44391.556084438744, 44430.0, 44722.0, 530775.0, 535624.0, 538336.0, 539756.0, 540137.0, 39398.40902386409, 40553.78338649845, 40707.59292407038, 42136.36795448009, 44154.0, 44866.0, 45011.54988450074, 46851.53148468472, 48125.518744813504, 48241.03517929552, 39655.40516892307, 39801.0, 39876.0, 40707.796461017504, 41723.0, 38667.80666096652, 39901.0, 40103.0, 40442.39336410015, 41658.0, 38205.4269185968, 38542.42186367151, 38886.0, 39038.0, 39044.21911561696, 31060.378792424475, 34717.13207169841, 35236.119097022776, 35277.0, 35501.289974199855, 24436.389090272885, 25619.743802561738, 25784.097556585428, 25818.741812581633, 25855.612165817904], "value": 19963.984114781648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.132692202176, 385.94210868369726, 389.51505375807125, 392.192084306329, 419.8320671731307, 15362.69274614507, 15364.69270614587, 18225.817741822593, 20817.687734683954, 21078.262260820837, 21846.672299915474, 22103.557928841412, 22547.323580292577, 22709.432264193405, 22784.65823012652, 5655.688937108457, 5704.942950570504, 5835.9124613130625, 5913.231279933602, 5953.970230148843, 4139.710220284582, 5835.562332825055, 5871.383504732005, 5912.852178695524, 5919.23050003499, 4325.935110973338, 6157.568970172089, 6413.230412350525, 6443.29123796382, 6522.771702990396, 6253.093301471306, 6444.452221561173, 6488.416042556169, 6499.675016249169, 6511.4465270452065, 5667.291588551431, 5732.31212254528, 5733.283339582552, 5739.598228124033, 5743.023685973353, 22031.559368812534, 26091.608625870627, 27066.32334191661, 27105.121078205913, 27381.86309068442, 2730.4675588260297, 2733.1390611957368, 2751.257160566656, 2755.8622068896675, 2757.6690797104475, 15182.62901888705, 15484.612884677861, 15536.300866461037, 15866.52400427989, 15990.76013859793, 1782.7504149419092, 1804.49474147239, 1822.5808064145187, 1838.2922574808795, 1841.8526517878538, 129620.35189823991, 133111.33444332815, 134411.0, 135046.3247683765, 136558.0, 10415.270931034755, 10969.012788849042, 11351.772964540829, 11494.88505114955, 11619.908416484945, 13314.267715275559, 14874.256287185814, 14915.105093694414, 14917.104973701613, 14919.179445130621, 8337.666493340319, 8503.872441913376, 8665.696700615448, 8721.127887211354, 8787.0, 8497.490150590984, 8523.403361764616, 8529.061803201643, 8663.870041949376, 8694.913050869536, 6458.113041916937, 6915.135608048994, 7241.89137162943, 7267.4549408794555, 7279.235680253497, 1901.4485799118102, 1934.6711059119984, 1937.6899696048847, 1945.552522919708, 1954.218312674913, 1034.896510348959, 1040.0015984654817, 1053.536443964653, 1078.094400703413, 1098.4672433869566, 17380.565485862953, 21971.560568788536, 22301.0, 22532.887335563217, 23045.654315185286, 1065.7655315830505, 1068.8396740488834, 1088.6733979806027, 1093.0763504838399, 1104.4532956186738, 9516.476593787409, 11111.888811118984, 11306.83039754388, 11931.761364772656, 11986.0, 402812.0, 733659.0, 742184.0, 759132.0, 769371.0, 105441.0, 109087.0, 141345.0, 160111.0, 167178.8051657146, 1068.551208492435, 1099.8680158381046, 1131.4342828585707, 1133.195431243826, 1135.6536256441864, 15668.0, 18782.96693681806, 20473.283435079702, 20518.281860134823, 20558.897205514477, 48754.04983800608, 61772.0, 61939.380606193365, 63948.68025659842, 64153.0, 90223.54888225517, 90994.63508047252, 91418.5429072877, 92931.0, 93217.2800127994, 8344.0, 8503.0, 8523.786905327417, 8554.101819309131, 8601.870971935552, 11503.827442588536, 13359.0, 13457.596272111852, 13826.30868456553, 13861.237631929936, 11521.884781152416, 11610.0, 11757.764844702888, 11835.408229588314, 11995.1003674723, 9076.455412675261, 11330.660080197607, 11467.598634047768, 11648.94175529117, 11762.70593235176, 11514.596989105341, 11542.59600913964, 11876.940615296868, 11962.820557691815, 11994.940025299818, 8271.95864020676, 8501.447405918596, 8530.44086773953, 8535.615897284513, 8567.828643427221, 8778.473291602524, 10031.54858031405, 11471.254368466023, 11497.597584084517, 11754.177207595387], "value": 10241.459557573744, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.2394475287203, 1459.9708005839877, 1466.7139907717997, 1476.9113853168803, 1485.7399955007877, 7987.480813747103, 8361.247487726103, 8372.162783721633, 8378.832423351529, 8392.286655634278, 7375.963120184391, 7657.00458940337, 7659.042619672541, 7927.0, 8171.346292296616, 2288.0847660935633, 2328.976710232893, 2330.778576035274, 2332.183735692511, 2335.1085620647245, 2298.000369839117, 2312.491251924574, 2340.0990618611786, 2353.505763789606, 2374.6556749271344, 2018.5962807438498, 2093.654546999743, 2218.866867987918, 2288.8855557222155, 2297.21894555851, 2274.6701728249395, 2281.0989659084566, 2282.269673704407, 2285.6000199964938, 2287.3709729824263, 2230.408941630469, 2279.0086312454137, 2293.3005433342823, 2334.7198336199594, 2338.976610233893, 8208.917910820875, 8289.04675962266, 8290.585470726439, 8291.461055031403, 8298.460600060977, 4972.651914365996, 5120.641555091145, 5139.331886854722, 5144.0740666679985, 5147.150720131174, 3026.515757478815, 3279.540864279003, 3441.2773317603333, 3455.7926524408363, 3510.80690562019, 1157.5369852059243, 1220.9572664956684, 1248.1200753468784, 1691.3995531586233, 1726.6460375622967, 10566.366018038942, 10569.260151789378, 10702.678919632424, 10711.94644026775, 10724.94637526823, 3960.0, 4473.46318441789, 4629.305604159335, 4687.414073240845, 4700.365450664185, 9190.03504632004, 9287.117723816227, 9399.671011514563, 9415.105564971316, 9420.19928306088, 5225.738713064332, 5229.294045303911, 5231.607629427808, 5233.476652334736, 5241.842744717665, 4255.851045213402, 4386.934195987063, 4468.151051300242, 4706.129366067288, 4736.289556566542, 3792.3363411402893, 3795.7153213509096, 3915.4909861717792, 3920.843166273317, 3931.5282166139673, 1257.3461799864203, 1282.6985658370274, 1285.5500574798932, 1296.319432298051, 1298.5519995601503, 682.1064405628642, 759.3811043999123, 770.7148355108645, 786.202004964961, 814.4014149600039, 5217.973910130425, 5264.263003179558, 5356.8660783479945, 5452.318460192476, 5551.2228288039705, 552.1717423864204, 569.792025910548, 570.3070769015583, 577.3822010448863, 586.9236999190078, 3525.7884526928465, 3682.8710995115043, 3713.1088538750505, 3820.5797362290127, 4055.8986025349013, 9632.90367096334, 9855.80288394228, 9867.40795552269, 9869.161121304625, 9869.358491698016, 9683.90316096844, 9803.264755143393, 9830.950845245728, 9841.311108222499, 9845.60617575289, 7300.452466065067, 7606.505577137468, 7671.731489397845, 7693.4999225051315, 7787.221277872168, 4971.900561988812, 5155.9742201288755, 5560.109493221166, 5616.691081990366, 5677.602567820378, 8784.297256219616, 8954.597043133204, 9126.859142607174, 9260.675876344296, 9291.76770580741, 8795.252403545514, 9074.637014519345, 9164.175224229852, 9319.534023298673, 9353.0, 5577.776888924398, 6785.660716964231, 6824.044633751179, 6843.794686159423, 7115.928840711734, 7509.1739908608915, 7754.6898124074405, 7780.572068536285, 7841.921580784119, 7855.685772569033, 6665.266820649627, 6757.054012438164, 6790.898136528055, 6810.693518791765, 6891.517593768388, 6936.375726184668, 6978.127734033246, 6982.581045137308, 7008.264132266038, 7025.929740702528, 6159.322474527708, 6179.3820617937845, 6268.153799237045, 6300.086487459201, 6366.681665916778, 4854.004928989478, 4883.121038213156, 4890.853274401631, 4927.384076990376, 5026.673266237683, 4827.95172048275, 4846.200376937766, 4932.235503496964, 4986.351774269322, 4995.850124496271], "value": 4299.814619590844, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.41840254379, 357.61020487668435, 363.29883325182396, 373.93643080676316, 374.58421152520714, 5248.343957005374, 5295.496927791858, 5328.360596728393, 5361.490658387456, 5432.375276843164, 4065.3901914712733, 4413.801378937947, 5042.445331013586, 5045.899082018357, 5138.152204886199, 3134.6081739782526, 3520.9295814083703, 3998.6404622428295, 4017.0517299109906, 4022.637962583367, 3445.5865296164498, 3487.4071407860597, 4045.5347635022054, 4076.2458945095254, 4090.734102283342, 3259.5925509311337, 3854.094287842355, 4044.170944956292, 4049.838006479752, 4059.330210515276, 3844.2503711776353, 3907.3943538751255, 3967.74209676373, 4021.4973128358956, 4100.835966561334, 3581.048328660886, 3583.8208089595414, 3591.5813253764877, 3604.5133906922756, 3623.5289412376223, 4966.0, 5005.324281222025, 5021.372328458942, 5029.547340739351, 5030.698158110525, 3786.5077539919907, 3944.112574670705, 4188.057687020427, 4469.240229161051, 4686.250199968023, 4878.951025529493, 5165.948340516585, 5239.580833533346, 5422.620416570841, 5471.644343117724, 3212.9357412851846, 3721.8511259549587, 3746.5129533160516, 3756.9624303756887, 3780.924381512382, 4905.583025442842, 5122.795088196468, 5597.524210442118, 5651.350094739158, 5686.232358631614, 3306.9338613228083, 3758.379867321861, 3779.7921114338974, 3792.7913964732206, 3816.4466152407745, 3845.9230815383535, 3850.0759817643566, 3853.7302388832513, 3853.8265778039495, 3871.341871881787, 4466.583063956076, 4484.798184081724, 4490.865274041784, 4499.920019195435, 4541.8183272669385, 4656.278276867091, 5258.815941442108, 5528.899018372993, 5537.529310008614, 5659.886802263932, 1232.48235740989, 1233.821700276252, 1234.6789834643057, 1242.372601836067, 1246.3145270101588, 728.1044315491869, 744.5272252119943, 857.0829212742431, 863.1799790199336, 865.2861389353808, 4513.751743654065, 4760.049548469622, 4801.959167353861, 4879.804807807719, 4894.776305923519, 4705.905881882343, 5193.5585475234275, 5399.974004939049, 5418.972905135449, 5476.91784623231, 4488.745659396911, 4583.358329833826, 4775.570198682066, 4836.879078023077, 4979.402471703419, 2488.7760101590943, 2583.457473930458, 2778.5268414481898, 2866.498362786504, 2891.465078960399, 5278.366596008504, 5417.4311697272005, 5687.8009269676195, 5692.975264452355, 5701.629394089371, 4851.951480485221, 5191.076970287953, 5211.947880521222, 5483.972580137074, 5552.278203833475, 4886.877828054327, 5310.867228319245, 5351.946480535223, 5441.646292990943, 5536.031194541019, 5354.089804733283, 5422.810201642924, 5434.565234781129, 5449.972750136224, 5487.807926722546, 4699.412573428322, 5305.973470132624, 5355.384130825005, 5544.889102217852, 5615.894039735099, 4860.513948605111, 5213.895722085613, 5539.9169012464035, 5575.498205161555, 5832.445917637818, 3462.5325581047246, 3813.675837553728, 3824.598417166269, 3852.6725228355904, 3971.8212680428874, 4991.750412479289, 5525.18982019647, 5577.8047768327915, 5606.85982850432, 5611.971940140274, 5265.631405801557, 5372.247885296139, 5472.972635136958, 5487.338640759308, 5487.722595122979, 4556.453225612815, 4690.507496712796, 4902.803887844589, 5286.889753151881, 5505.256790333414, 4773.63704966044, 5334.306540149756, 5377.704226267593, 5380.273663055437, 5395.217693434509, 4575.40519732446, 5333.866653333697, 5441.809536666197, 5448.727563621882, 5456.945430545803, 4720.989330843763, 5348.983693098299, 5350.277712508761, 5369.731513424391, 5423.156126916867], "value": 3963.531569773909, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8933659951003, 748.2069006852734, 768.581123287808, 794.3010151067062, 826.3389288569143, 13591.796123058137, 13619.931900340509, 14911.552653420402, 15743.448979285728, 15844.366225350986, 14393.640158996004, 14469.421223151061, 14556.272186390665, 14571.489997850078, 14578.562643120724, 678.4572342126304, 700.6426722371576, 704.2710794327871, 844.9070602233734, 861.2378045429808, 831.1729828820332, 845.8646616541355, 849.5497386385226, 862.9309655227567, 863.7581477186367, 911.6854685133618, 914.0996118822954, 916.4547094478775, 917.3853518142861, 919.8068405634825, 709.3438569323407, 903.2142036428284, 908.6047569307373, 909.1363204955253, 911.6535716427782, 543.9755211015514, 661.7055410342399, 678.3284548297199, 678.7556479667315, 685.3831551603597, 15339.309731062129, 15358.769618455732, 15387.615309617237, 15397.53807385769, 15429.382824687, 13742.0, 13852.584422467342, 13878.236696981661, 13915.512957046454, 13917.30413479322, 12337.50649974, 12671.683207919783, 12804.871951280555, 12913.935430322883, 13024.86975130246, 4368.08154814049, 4452.3989261449615, 4488.079943611552, 4555.63554915606, 4654.581087702123, 97616.51191744138, 99303.0069699301, 101114.85506884058, 101736.0, 102180.46729298992, 10480.580776768844, 10568.418736969386, 10780.353178809297, 10876.891231087588, 11339.206255562032, 21689.915504224726, 21740.56518869614, 22552.66171007436, 22561.98471068806, 22562.887185563966, 7707.884381734279, 7742.651580678883, 7758.262965018314, 7840.882386764203, 7952.32405245549, 4165.500139983222, 4217.536071032184, 4251.957480425218, 4267.1892340455215, 4408.515063343029, 3487.89536313911, 3536.1513236823494, 3549.18368775178, 3567.7680950738118, 3580.964190358063, 650.632392698124, 653.7581094994787, 655.131950166032, 666.1939053745023, 667.9599224046573, 622.3745136138152, 635.463033736492, 642.8135840606171, 645.2063961327593, 648.42938214372, 9848.458334791656, 9852.359596626196, 9946.552405141785, 9954.502274886372, 10000.999900010087, 624.6064979063161, 625.2309659119309, 657.2844874876569, 657.6777379084215, 657.9769708060195, 4428.778561071934, 4814.927776083362, 4816.397263139061, 4818.759062046954, 4876.195427754452, 97436.0, 98201.0, 110881.0, 111031.88968110216, 112478.87521124848, 91173.0, 93774.0, 93799.0, 95673.0, 97441.51279243559, 61449.69275153685, 77233.0, 78805.60597197092, 81232.59383703044, 81345.59327203444, 8909.420887642282, 9307.674231401868, 9350.971393146885, 9411.058894110807, 9519.238460923249, 47601.0, 47736.0, 48506.0, 48809.0, 52649.736751316, 58086.41913580979, 63200.367996321285, 64528.0, 70661.64669176827, 71609.92585111332, 12874.420651070912, 12904.870951290366, 13254.072214944861, 13381.264030478416, 13763.105398149088, 14531.564053078424, 14815.92592037076, 14902.701945960804, 15054.096754194783, 15171.0, 13698.931505342409, 13910.930445347709, 13945.16329020262, 14130.293485325898, 14389.784153237919, 13561.168153088931, 13892.93053534726, 14025.509107181608, 14057.886586901848, 14174.220417876702, 11876.76246475083, 13511.729765404834, 13714.451421943011, 14133.434662613381, 14201.431942722176, 10970.780584388427, 11036.889631103586, 11190.659545398088, 11384.658460246206, 11673.299602023906, 9129.634814607341, 9302.255819534555, 9957.950210249192, 10485.528151233366, 10759.731006724895], "value": 7504.9951735147115, "unit": "score"}], "name": "dromaeo_css", "value": 7283.670240436945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 108.0, 170.0, 113.0, 112.0, 112.0, 126.0, 127.0, 141.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 184.0, 183.0, 184.0, 180.0, 182.0, 187.0, 182.0, 182.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 86.0, 49.0, 74.0, 82.0, 81.0, 98.0, 57.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 86.0, 70.0, 68.0, 70.0, 81.0, 68.0, 70.0, 83.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 88.0, 85.0, 90.0, 86.0, 88.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 85.0, 108.0, 131.0, 130.0, 85.0, 85.0, 104.0, 116.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 57.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 70.0, 78.0, 73.0, 70.0, 70.0, 71.0, 71.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 86.0, 93.0, 107.0, 108.0, 87.0, 92.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 142.0, 141.0, 138.0, 139.0, 141.0, 141.0, 177.0, 151.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 239.0, 195.0, 173.0, 173.0, 173.0, 172.0, 175.0, 177.0, 234.0], "value": 188.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 67.0, 67.0, 67.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1478.9, "alertThreshold": 2.0}]} 09:03:56 INFO - Return code: 0 09:03:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:56 ERROR - # TBPL SUCCESS # 09:03:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:03:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:03:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:03:56 INFO - 2017-01-16 09:03:56.539 screenresolution[1656:9761] starting screenresolution argv=screenresolution get 09:03:56 INFO - 2017-01-16 09:03:56.541 screenresolution[1656:9761] Display 0: 1600x1200x32@60 09:03:56 INFO - 2017-01-16 09:03:56.548 screenresolution[1657:9764] starting screenresolution argv=screenresolution list 09:03:56 INFO - Available Modes on Display 0 09:03:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:03:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:03:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:03:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:03:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:03:56 INFO - Intel Iris: 09:03:56 INFO - Chipset Model: Intel Iris 09:03:56 INFO - Type: GPU 09:03:56 INFO - Bus: Built-In 09:03:56 INFO - VRAM (Dynamic, Max): 1536 MB 09:03:56 INFO - Vendor: Intel (0x8086) 09:03:56 INFO - Device ID: 0x0a2e 09:03:56 INFO - Revision ID: 0x0009 09:03:56 INFO - Displays: 09:03:56 INFO - Display: 09:03:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:03:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:03:56 INFO - Display Serial Number: 1600x1200 60 09:03:56 INFO - Main Display: Yes 09:03:56 INFO - Mirror: Off 09:03:56 INFO - Online: Yes 09:03:56 INFO - Rotation: Supported 09:03:56 INFO - Return code: 0 09:03:56 INFO - Running post-action listener: _resource_record_post_action 09:03:56 INFO - [mozharness: 2017-01-16 17:03:56.785603Z] Finished run-tests step (success) 09:03:56 INFO - Running post-run listener: _resource_record_post_run 09:03:56 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32316416; Write bytes: 550147072; Read time: 196; Write time: 1644 09:03:56 INFO - TinderboxPrint: CPU usage
53.7% 09:03:56 INFO - TinderboxPrint: I/O read bytes / time
32,316,416 / 196 09:03:56 INFO - TinderboxPrint: I/O write bytes / time
550,147,072 / 1,644 09:03:56 INFO - TinderboxPrint: CPU idle
2,224.3 (46.3%) 09:03:56 INFO - TinderboxPrint: CPU system
960.5 (20.0%) 09:03:56 INFO - TinderboxPrint: CPU user
1,620.9 (33.7%) 09:03:56 INFO - TinderboxPrint: Swap in / out
279,502,848 / 0 09:03:56 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247577088; Write bytes: 242206208; Read time: 17901; Write time: 517 09:03:56 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30227456; Write bytes: 294301184; Read time: 175; Write time: 1089 09:03:57 INFO - Running post-run listener: _upload_blobber_files 09:03:57 INFO - Blob upload gear active. 09:03:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:57 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 09:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:59 INFO - (blobuploader) - INFO - Done attempting. 09:03:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:00 INFO - (blobuploader) - INFO - Done attempting. 09:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:01 INFO - (blobuploader) - INFO - Done attempting. 09:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:04 INFO - (blobuploader) - INFO - Done attempting. 09:04:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:04 INFO - Return code: 0 09:04:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd099c41dbfdbba08f11d9a0c40fec86f48621faefe3c5c83e6d7c6a8b175d18065fe2f409d148f42d279cc96d247a8a58e4ea5f6e5a4822e562a7eab541a47b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69234ce06289c3787590bd01314094e1b5f2a568cabee3d5b310ee7e74b1783524ad5f3a4e233bd43fd0ac9da304c59732d4d1ccab002523b11910b566e84bee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d573c1d0e5fe29ebdce866df7af12401f61c8cdaca5832b44afc7b5293e3188f2d45c3e7b20fefa6ef48414abcf47683beef57234dad68a1ea8827cd5989d5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5afcaba69fe1ca783ee10bf3cba8c29d1afb7c66a3719fa9ec0a56f56a565113f46899f45e8f0f4cfbf9c80ff7ca02a7486a499e4a3fccd2cc4c6305b274580"} 09:04:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:04 INFO - Contents: 09:04:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd099c41dbfdbba08f11d9a0c40fec86f48621faefe3c5c83e6d7c6a8b175d18065fe2f409d148f42d279cc96d247a8a58e4ea5f6e5a4822e562a7eab541a47b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69234ce06289c3787590bd01314094e1b5f2a568cabee3d5b310ee7e74b1783524ad5f3a4e233bd43fd0ac9da304c59732d4d1ccab002523b11910b566e84bee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d573c1d0e5fe29ebdce866df7af12401f61c8cdaca5832b44afc7b5293e3188f2d45c3e7b20fefa6ef48414abcf47683beef57234dad68a1ea8827cd5989d5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5afcaba69fe1ca783ee10bf3cba8c29d1afb7c66a3719fa9ec0a56f56a565113f46899f45e8f0f4cfbf9c80ff7ca02a7486a499e4a3fccd2cc4c6305b274580"} 09:04:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:04 INFO - Copying logs to upload dir... 09:04:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.178116 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-16 09:04:04.464818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 09:04:04.468586) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.20vHCTAfjZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd099c41dbfdbba08f11d9a0c40fec86f48621faefe3c5c83e6d7c6a8b175d18065fe2f409d148f42d279cc96d247a8a58e4ea5f6e5a4822e562a7eab541a47b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69234ce06289c3787590bd01314094e1b5f2a568cabee3d5b310ee7e74b1783524ad5f3a4e233bd43fd0ac9da304c59732d4d1ccab002523b11910b566e84bee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d573c1d0e5fe29ebdce866df7af12401f61c8cdaca5832b44afc7b5293e3188f2d45c3e7b20fefa6ef48414abcf47683beef57234dad68a1ea8827cd5989d5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5afcaba69fe1ca783ee10bf3cba8c29d1afb7c66a3719fa9ec0a56f56a565113f46899f45e8f0f4cfbf9c80ff7ca02a7486a499e4a3fccd2cc4c6305b274580"} build_url:https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011036 build_url: 'https://queue.taskcluster.net/v1/task/YaSQu6kNTxSaZ0d1vWYIvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd099c41dbfdbba08f11d9a0c40fec86f48621faefe3c5c83e6d7c6a8b175d18065fe2f409d148f42d279cc96d247a8a58e4ea5f6e5a4822e562a7eab541a47b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69234ce06289c3787590bd01314094e1b5f2a568cabee3d5b310ee7e74b1783524ad5f3a4e233bd43fd0ac9da304c59732d4d1ccab002523b11910b566e84bee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d573c1d0e5fe29ebdce866df7af12401f61c8cdaca5832b44afc7b5293e3188f2d45c3e7b20fefa6ef48414abcf47683beef57234dad68a1ea8827cd5989d5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5afcaba69fe1ca783ee10bf3cba8c29d1afb7c66a3719fa9ec0a56f56a565113f46899f45e8f0f4cfbf9c80ff7ca02a7486a499e4a3fccd2cc4c6305b274580"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 09:04:04.503885) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 09:04:04.504344) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.20vHCTAfjZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.kFL0mvzvbx/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004853 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 09:04:04.553507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 09:04:04.553956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 09:04:04.554324) ========= ========= Total master_lag: 0.19 =========