builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0338 starttime: 1485316758.19 results: success (0) buildid: 20170124184448 builduid: 8eef496213834187aef34f07be7c71ac revision: 36896a90b68cc4e3a9a7d3d18186d95d6a56d852 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.193592) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.194143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.194442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.219803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.220198) ========= 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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-24 19:59:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 179M=0s 2017-01-24 19:59:18 (179 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.358077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.358386) ========= 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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.019718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:18.408668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 19:59:18.409258) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 36896a90b68cc4e3a9a7d3d18186d95d6a56d852 --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 36896a90b68cc4e3a9a7d3d18186d95d6a56d852 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YiNeJTfvMt/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.dmwMD5EoPz/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-24 19:59:18,500 truncating revision to first 12 chars 2017-01-24 19:59:18,500 Setting DEBUG logging. 2017-01-24 19:59:18,500 attempt 1/10 2017-01-24 19:59:18,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/36896a90b68c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 19:59:19,416 unpacking tar archive at: mozilla-central-36896a90b68c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.172232 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 19:59:19.608003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:19.608360) ========= script_repo_revision: 36896a90b68cc4e3a9a7d3d18186d95d6a56d852 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:19.608770) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:19.609044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 19:59:19.629267) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-24 19:59:19.629644) ========= /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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 19:59:19 INFO - MultiFileLogger online at 20170124 19:59:19 in /builds/slave/test 19:59:19 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 19:59:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:59:19 INFO - {'append_to_log': False, 19:59:19 INFO - 'base_work_dir': '/builds/slave/test', 19:59:19 INFO - 'blob_upload_branch': 'Firefox', 19:59:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:59:19 INFO - 'branch': 'Firefox', 19:59:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:19 INFO - 'config_files': ('talos/mac_config.py',), 19:59:19 INFO - 'default_actions': ('clobber', 19:59:19 INFO - 'read-buildbot-config', 19:59:19 INFO - 'download-and-extract', 19:59:19 INFO - 'populate-webroot', 19:59:19 INFO - 'create-virtualenv', 19:59:19 INFO - 'install', 19:59:19 INFO - 'run-tests'), 19:59:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:19 INFO - 'download_minidump_stackwalk': True, 19:59:19 INFO - 'download_symbols': 'ondemand', 19:59:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:19 INFO - 'installer_path': 'installer.exe', 19:59:19 INFO - 'log_level': 'info', 19:59:19 INFO - 'log_name': 'talos', 19:59:19 INFO - 'log_to_console': True, 19:59:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:59:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:59:19 INFO - 'opt_config_files': (), 19:59:19 INFO - 'pip_index': False, 19:59:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:59:19 INFO - 'cmd': ('bash', 19:59:19 INFO - '-c', 19:59:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:59:19 INFO - 'enabled': True, 19:59:19 INFO - 'halt_on_failure': False, 19:59:19 INFO - 'name': 'check_screen_resolution'},), 19:59:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:59:19 INFO - 'cmd': ('bash', 19:59:19 INFO - '-c', 19:59:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:59:19 INFO - 'enabled': True, 19:59:19 INFO - 'halt_on_failure': False, 19:59:19 INFO - 'name': 'check_screen_resolution'},), 19:59:19 INFO - 'run_cmd_checks_enabled': True, 19:59:19 INFO - 'sps_profile': False, 19:59:19 INFO - 'sps_profile_interval': 0, 19:59:19 INFO - 'suite': 'dromaeojs', 19:59:19 INFO - 'system_bits': '32', 19:59:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:19 INFO - 'title': 't-yosemite-r7-0338', 19:59:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:19 INFO - 'use_talos_json': True, 19:59:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:59:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:19 INFO - 'work_dir': 'build'} 19:59:19 INFO - [mozharness: 2017-01-25 03:59:19.839505Z] Running clobber step. 19:59:19 INFO - Running pre-action listener: _resource_record_pre_action 19:59:19 INFO - Running main action method: clobber 19:59:19 INFO - rmtree: /builds/slave/test/build 19:59:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:59:21 INFO - Running post-action listener: _resource_record_post_action 19:59:21 INFO - [mozharness: 2017-01-25 03:59:21.491523Z] Finished clobber step (success) 19:59:21 INFO - [mozharness: 2017-01-25 03:59:21.491644Z] Running read-buildbot-config step. 19:59:21 INFO - Running pre-action listener: _resource_record_pre_action 19:59:21 INFO - Running main action method: read_buildbot_config 19:59:21 INFO - Using buildbot properties: 19:59:21 INFO - { 19:59:21 INFO - "project": "", 19:59:21 INFO - "product": "firefox", 19:59:21 INFO - "script_repo_revision": "production", 19:59:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:59:21 INFO - "repository": "", 19:59:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:59:21 INFO - "buildid": "20170124184448", 19:59:21 INFO - "pgo_build": "False", 19:59:21 INFO - "basedir": "/builds/slave/test", 19:59:21 INFO - "buildnumber": 31, 19:59:21 INFO - "slavename": "t-yosemite-r7-0338", 19:59:21 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 19:59:21 INFO - "platform": "yosemite_r7", 19:59:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:59:21 INFO - "branch": "mozilla-central", 19:59:21 INFO - "repo_path": "mozilla-central", 19:59:21 INFO - "revision": "36896a90b68cc4e3a9a7d3d18186d95d6a56d852", 19:59:21 INFO - "stage_platform": "macosx64", 19:59:21 INFO - "builduid": "8eef496213834187aef34f07be7c71ac", 19:59:21 INFO - "slavebuilddir": "test" 19:59:21 INFO - } 19:59:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 19:59:21 INFO - Running post-action listener: _resource_record_post_action 19:59:21 INFO - [mozharness: 2017-01-25 03:59:21.494310Z] Finished read-buildbot-config step (success) 19:59:21 INFO - [mozharness: 2017-01-25 03:59:21.494392Z] Running download-and-extract step. 19:59:21 INFO - Running pre-action listener: _resource_record_pre_action 19:59:21 INFO - Running main action method: download_and_extract 19:59:21 INFO - mkdir: /builds/slave/test/build/tests 19:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:21 INFO - trying https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 19:59:21 INFO - Downloading https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 19:59:23 INFO - Downloaded 1199 bytes. 19:59:23 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:59:23 INFO - Using the following test package requirements: 19:59:23 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:59:23 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 19:59:23 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 19:59:23 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'jsshell-mac.zip'], 19:59:23 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 19:59:23 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:59:23 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 19:59:23 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 19:59:23 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 19:59:23 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:59:23 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 19:59:23 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:59:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:59:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:59:23 INFO - Fetch https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:59:23 INFO - Expected file size: 16351145 19:59:23 INFO - Obtained file size: 16351145 19:59:30 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:59:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:59:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:59:30 INFO - Fetch https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:59:31 INFO - Expected file size: 16351145 19:59:31 INFO - Obtained file size: 16351145 19:59:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 19:59:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:59:37 INFO - Fetch https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 19:59:39 INFO - Expected file size: 14403431 19:59:39 INFO - Obtained file size: 14403431 19:59:39 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')]} 19:59:39 INFO - trying https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:59:39 INFO - Downloading https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 19:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 19:59:41 INFO - Downloaded 69967500 bytes. 19:59:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:59:41 INFO - mkdir: /builds/slave/test/properties 19:59:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:41 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:41 INFO - Contents: 19:59:41 INFO - build_url:https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:59:42 INFO - Running post-action listener: _resource_record_post_action 19:59:42 INFO - Running post-action listener: set_extra_try_arguments 19:59:42 INFO - [mozharness: 2017-01-25 03:59:42.351729Z] Finished download-and-extract step (success) 19:59:42 INFO - [mozharness: 2017-01-25 03:59:42.351855Z] Running populate-webroot step. 19:59:42 INFO - Running pre-action listener: _resource_record_pre_action 19:59:42 INFO - Running main action method: populate_webroot 19:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:42 INFO - '--tppagecycles', 19:59:42 INFO - '7'], 19:59:42 INFO - 'tests': ['tsvgm']}}, 19:59:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:59:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:59:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:59:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:59:42 INFO - 'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:59:42 INFO - 'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['damp', 'tps']}, 19:59:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:59:42 INFO - 'tests': ['damp', 'tps']}, 19:59:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['dromaeo_dom']}, 19:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['basic_compositor_video']}, 19:59:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:59:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['a11yr', 19:59:42 INFO - 'ts_paint', 19:59:42 INFO - 'tpaint', 19:59:42 INFO - 'sessionrestore', 19:59:42 INFO - 'sessionrestore_no_auto_restore', 19:59:42 INFO - 'tabpaint']}, 19:59:42 INFO - 'other-e10s': {'tests': ['a11yr', 19:59:42 INFO - 'ts_paint', 19:59:42 INFO - 'tpaint', 19:59:42 INFO - 'sessionrestore', 19:59:42 INFO - 'sessionrestore_no_auto_restore', 19:59:42 INFO - 'tabpaint']}, 19:59:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:59:42 INFO - 'ts_paint', 19:59:42 INFO - 'tpaint', 19:59:42 INFO - 'sessionrestore', 19:59:42 INFO - 'sessionrestore_no_auto_restore', 19:59:42 INFO - 'tabpaint']}, 19:59:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:59:42 INFO - 'ts_paint', 19:59:42 INFO - 'tpaint', 19:59:42 INFO - 'sessionrestore', 19:59:42 INFO - 'sessionrestore_no_auto_restore', 19:59:42 INFO - 'tabpaint']}, 19:59:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['a11yr', 19:59:42 INFO - 'ts_paint', 19:59:42 INFO - 'tpaint', 19:59:42 INFO - 'sessionrestore', 19:59:42 INFO - 'sessionrestore_no_auto_restore', 19:59:42 INFO - 'tabpaint']}, 19:59:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['a11yr', 19:59:42 INFO - 'ts_paint', 19:59:42 INFO - 'tpaint', 19:59:42 INFO - 'sessionrestore', 19:59:42 INFO - 'sessionrestore_no_auto_restore', 19:59:42 INFO - 'tabpaint']}, 19:59:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['tsvgx', 19:59:42 INFO - 'tsvgr_opacity', 19:59:42 INFO - 'tart', 19:59:42 INFO - 'tscrollx', 19:59:42 INFO - 'cart', 19:59:42 INFO - 'tsvg_static']}, 19:59:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:59:42 INFO - 'tsvgr_opacity', 19:59:42 INFO - 'tart', 19:59:42 INFO - 'tscrollx', 19:59:42 INFO - 'cart', 19:59:42 INFO - 'tsvg_static']}, 19:59:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:59:42 INFO - 'talos_options': ['--disable-e10s'], 19:59:42 INFO - 'tests': ['tp5o']}, 19:59:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:59:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:59:42 INFO - 'talos_options': ['--disable-e10s', 19:59:42 INFO - '--xperf_path', 19:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:42 INFO - 'tests': ['tp5n']}, 19:59:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:59:42 INFO - 'talos_options': ['--xperf_path', 19:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:42 INFO - 'tests': ['tp5n']}}, 19:59:42 INFO - 'talos.zip': {'path': '', 19:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:42 INFO - Running post-action listener: _resource_record_post_action 19:59:42 INFO - [mozharness: 2017-01-25 03:59:42.370189Z] Finished populate-webroot step (success) 19:59:42 INFO - [mozharness: 2017-01-25 03:59:42.370308Z] Running create-virtualenv step. 19:59:42 INFO - Running pre-action listener: _resource_record_pre_action 19:59:42 INFO - Running main action method: create_virtualenv 19:59:42 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:42 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 19:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:42 INFO - Using real prefix '/tools/python27' 19:59:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:46 INFO - Installing pip.................done. 19:59:46 INFO - Return code: 0 19:59:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:59:46 INFO - Reading from file tmpfile_stdout 19:59:46 INFO - Output received: 19:59:46 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) 19:59:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:46 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')]} 19:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 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')]} 19:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 19:59:46 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 19:59:46 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 19:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 19:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:46 INFO - 'HOME': '/Users/cltbld', 19:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:46 INFO - 'LOGNAME': 'cltbld', 19:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:46 INFO - 'MOZ_NO_REMOTE': '1', 19:59:46 INFO - 'NO_EM_RESTART': '1', 19:59:46 INFO - 'PAGER': '/bin/cat', 19:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:46 INFO - 'PWD': '/builds/slave/test', 19:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:46 INFO - 'SHELL': '/bin/bash', 19:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 19:59:46 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 19:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:46 INFO - 'USER': 'cltbld', 19:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:46 INFO - 'XPC_FLAGS': '0x0', 19:59:46 INFO - 'XPC_SERVICE_NAME': '0', 19:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:46 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 19:59:46 INFO - Cleaning up... 19:59:46 INFO - Return code: 0 19:59:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:59:46 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')]} 19:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 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')]} 19:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 19:59:46 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 19:59:46 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 19:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 19:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:46 INFO - 'HOME': '/Users/cltbld', 19:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:46 INFO - 'LOGNAME': 'cltbld', 19:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:46 INFO - 'MOZ_NO_REMOTE': '1', 19:59:46 INFO - 'NO_EM_RESTART': '1', 19:59:46 INFO - 'PAGER': '/bin/cat', 19:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:46 INFO - 'PWD': '/builds/slave/test', 19:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:46 INFO - 'SHELL': '/bin/bash', 19:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 19:59:46 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 19:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:46 INFO - 'USER': 'cltbld', 19:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:46 INFO - 'XPC_FLAGS': '0x0', 19:59:46 INFO - 'XPC_SERVICE_NAME': '0', 19:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:46 INFO - Downloading/unpacking psutil>=3.1.1 19:59:46 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 19:59:46 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 19:59:46 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 19:59:46 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 19:59:46 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 19:59:46 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 19:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:50 INFO - Installing collected packages: psutil 19:59:50 INFO - Running setup.py install for psutil 19:59:50 INFO - building 'psutil._psutil_osx' extension 19:59:50 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 19:59:50 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 19:59:50 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 19:59:51 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 19:59:51 INFO - building 'psutil._psutil_posix' extension 19:59:51 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 19:59:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:59:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:59:51 INFO - ^ 19:59:51 INFO - 1 warning generated. 19:59:51 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 19:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:51 INFO - Successfully installed psutil 19:59:51 INFO - Cleaning up... 19:59:51 INFO - Return code: 0 19:59:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 19:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 19:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:51 INFO - 'HOME': '/Users/cltbld', 19:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:51 INFO - 'LOGNAME': 'cltbld', 19:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:51 INFO - 'MOZ_NO_REMOTE': '1', 19:59:51 INFO - 'NO_EM_RESTART': '1', 19:59:51 INFO - 'PAGER': '/bin/cat', 19:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:51 INFO - 'PWD': '/builds/slave/test', 19:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:51 INFO - 'SHELL': '/bin/bash', 19:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 19:59:51 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 19:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:51 INFO - 'USER': 'cltbld', 19:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:51 INFO - 'XPC_FLAGS': '0x0', 19:59:51 INFO - 'XPC_SERVICE_NAME': '0', 19:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:59:54 INFO - Installing collected packages: mozsystemmonitor 19:59:54 INFO - Running setup.py install for mozsystemmonitor 19:59:54 INFO - Successfully installed mozsystemmonitor 19:59:54 INFO - Cleaning up... 19:59:54 INFO - Return code: 0 19:59:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 19:59: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==2.5.1'] in /builds/slave/test/build 19:59: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==2.5.1 19:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 19:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:54 INFO - 'HOME': '/Users/cltbld', 19:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:54 INFO - 'LOGNAME': 'cltbld', 19:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:54 INFO - 'MOZ_NO_REMOTE': '1', 19:59:54 INFO - 'NO_EM_RESTART': '1', 19:59:54 INFO - 'PAGER': '/bin/cat', 19:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:54 INFO - 'PWD': '/builds/slave/test', 19:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:54 INFO - 'SHELL': '/bin/bash', 19:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 19:59:54 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 19:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:54 INFO - 'USER': 'cltbld', 19:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:54 INFO - 'XPC_FLAGS': '0x0', 19:59:54 INFO - 'XPC_SERVICE_NAME': '0', 19:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:59:54 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 19:59:54 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 19:59:54 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 19:59:54 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 19:59:54 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 19:59:54 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 19:59:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:59:57 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 19:59:57 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 19:59:57 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 19:59:57 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 19:59:57 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 19:59:57 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 19:59:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:57 INFO - warning: no files found matching '*.txt' 19:59:57 INFO - no previously-included directories found matching 'build' 19:59:57 INFO - no previously-included directories found matching 'dist' 19:59:57 INFO - no previously-included directories found matching '.git*' 19:59:57 INFO - Installing collected packages: jsonschema, functools32 19:59:57 INFO - Running setup.py install for functools32 19:59:58 INFO - warning: no files found matching '*.txt' 19:59:58 INFO - no previously-included directories found matching 'build' 19:59:58 INFO - no previously-included directories found matching 'dist' 19:59:58 INFO - no previously-included directories found matching '.git*' 19:59:58 INFO - Successfully installed jsonschema functools32 19:59:58 INFO - Cleaning up... 19:59:58 INFO - Return code: 0 19:59:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:59:58 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')]} 19:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 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')]} 19:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 19:59:58 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 19:59:58 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 19:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 19:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:58 INFO - 'HOME': '/Users/cltbld', 19:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:58 INFO - 'LOGNAME': 'cltbld', 19:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:58 INFO - 'MOZ_NO_REMOTE': '1', 19:59:58 INFO - 'NO_EM_RESTART': '1', 19:59:58 INFO - 'PAGER': '/bin/cat', 19:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:58 INFO - 'PWD': '/builds/slave/test', 19:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:58 INFO - 'SHELL': '/bin/bash', 19:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 19:59:58 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 19:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:58 INFO - 'USER': 'cltbld', 19:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:58 INFO - 'XPC_FLAGS': '0x0', 19:59:58 INFO - 'XPC_SERVICE_NAME': '0', 19:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:59:58 INFO - Cleaning up... 19:59:58 INFO - Return code: 0 19:59:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:59:58 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')]} 19:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 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')]} 19:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 19:59:58 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 19:59:58 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 19:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 19:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:58 INFO - 'HOME': '/Users/cltbld', 19:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:58 INFO - 'LOGNAME': 'cltbld', 19:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:58 INFO - 'MOZ_NO_REMOTE': '1', 19:59:58 INFO - 'NO_EM_RESTART': '1', 19:59:58 INFO - 'PAGER': '/bin/cat', 19:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:58 INFO - 'PWD': '/builds/slave/test', 19:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:58 INFO - 'SHELL': '/bin/bash', 19:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 19:59:58 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 19:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:58 INFO - 'USER': 'cltbld', 19:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:58 INFO - 'XPC_FLAGS': '0x0', 19:59:58 INFO - 'XPC_SERVICE_NAME': '0', 19:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:58 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 19:59:58 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 19:59:58 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 19:59:58 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 19:59:58 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 19:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:00:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:00:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:02 INFO - Downloading docopt-0.6.1.tar.gz 20:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:00:02 INFO - Running setup.py install for blobuploader 20:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:00:02 INFO - Running setup.py install for requests 20:00:03 INFO - Running setup.py install for docopt 20:00:03 INFO - Successfully installed blobuploader requests docopt 20:00:03 INFO - Cleaning up... 20:00:03 INFO - Return code: 0 20:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:03 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 20:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:00:03 INFO - 'HOME': '/Users/cltbld', 20:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:00:03 INFO - 'LOGNAME': 'cltbld', 20:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:03 INFO - 'MOZ_NO_REMOTE': '1', 20:00:03 INFO - 'NO_EM_RESTART': '1', 20:00:03 INFO - 'PAGER': '/bin/cat', 20:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:03 INFO - 'PWD': '/builds/slave/test', 20:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:00:03 INFO - 'SHELL': '/bin/bash', 20:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 20:00:03 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:00:03 INFO - 'USER': 'cltbld', 20:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:03 INFO - 'XPC_FLAGS': '0x0', 20:00:03 INFO - 'XPC_SERVICE_NAME': '0', 20:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:00:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-yfJeaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:00:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-A8D5I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:00:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Y4Rk2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Ind7MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-yOWAAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-EQOWtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-VoY7kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-XLOhf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-di9bsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-1BDQSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-c6zje7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-x4ZCqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-CoRIkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:05 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-BGpjjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:05 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-dz8KSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:05 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-a9Ibn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:05 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-QqdPiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:00:05 INFO - Running setup.py install for manifestparser 20:00:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Running setup.py install for mozcrash 20:00:05 INFO - Running setup.py install for mozdebug 20:00:05 INFO - Running setup.py install for mozdevice 20:00:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Running setup.py install for mozfile 20:00:06 INFO - Running setup.py install for mozhttpd 20:00:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Running setup.py install for mozinfo 20:00:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Running setup.py install for mozInstall 20:00:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Running setup.py install for mozleak 20:00:06 INFO - Running setup.py install for mozlog 20:00:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Running setup.py install for moznetwork 20:00:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:00:07 INFO - Running setup.py install for mozprocess 20:00:07 INFO - Running setup.py install for mozprofile 20:00:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:00:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:00:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:00:07 INFO - Running setup.py install for mozrunner 20:00:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:00:07 INFO - Running setup.py install for mozscreenshot 20:00:07 INFO - Running setup.py install for moztest 20:00:07 INFO - Running setup.py install for mozversion 20:00:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:00:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:00:08 INFO - Cleaning up... 20:00:08 INFO - Return code: 0 20:00:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:08 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:00:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 20:00:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:00:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:00:08 INFO - 'HOME': '/Users/cltbld', 20:00:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:00:08 INFO - 'LOGNAME': 'cltbld', 20:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:08 INFO - 'MOZ_NO_REMOTE': '1', 20:00:08 INFO - 'NO_EM_RESTART': '1', 20:00:08 INFO - 'PAGER': '/bin/cat', 20:00:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:08 INFO - 'PWD': '/builds/slave/test', 20:00:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:00:08 INFO - 'SHELL': '/bin/bash', 20:00:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 20:00:08 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:00:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:00:08 INFO - 'USER': 'cltbld', 20:00:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:00:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:08 INFO - 'XPC_FLAGS': '0x0', 20:00:08 INFO - 'XPC_SERVICE_NAME': '0', 20:00:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:00:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-0M80pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:00:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Qw1bm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:00:08 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)) 20:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:00:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-GJZjp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:00:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-r3ulpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:00:08 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)) 20:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:00:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-szk0DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:00:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-wxGtZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:00:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-kmryUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-oPEbx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-WSUSn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-2VRh_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-tLF26d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-T9s0si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:09 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)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-vBl4t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-dPKuWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:09 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)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-FNuftx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:09 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-L28hnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:10 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)) 20:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:10 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-8kmfp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:00:10 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)) 20:00:10 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)) 20:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:00:10 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)) 20:00:10 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)) 20:00:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:12 INFO - Downloading blessings-1.6.tar.gz 20:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:12 INFO - Installing collected packages: blessings 20:00:12 INFO - Running setup.py install for blessings 20:00:13 INFO - Successfully installed blessings 20:00:13 INFO - Cleaning up... 20:00:13 INFO - Return code: 0 20:00:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:13 INFO - Reading from file tmpfile_stdout 20:00:13 INFO - Current package versions: 20:00:13 INFO - blessings == 1.6 20:00:13 INFO - blobuploader == 1.2.4 20:00:13 INFO - docopt == 0.6.1 20:00:13 INFO - functools32 == 3.2.3-2 20:00:13 INFO - jsonschema == 2.5.1 20:00:13 INFO - manifestparser == 1.1 20:00:13 INFO - mozInstall == 1.12 20:00:13 INFO - mozcrash == 1.0 20:00:13 INFO - mozdebug == 0.1 20:00:13 INFO - mozdevice == 0.49 20:00:13 INFO - mozfile == 1.2 20:00:13 INFO - mozhttpd == 0.7 20:00:13 INFO - mozinfo == 0.9 20:00:13 INFO - mozleak == 0.1 20:00:13 INFO - mozlog == 3.4 20:00:13 INFO - moznetwork == 0.27 20:00:13 INFO - mozprocess == 0.24 20:00:13 INFO - mozprofile == 0.28 20:00:13 INFO - mozrunner == 6.13 20:00:13 INFO - mozscreenshot == 0.1 20:00:13 INFO - mozsystemmonitor == 0.3 20:00:13 INFO - moztest == 0.8 20:00:13 INFO - mozversion == 1.4 20:00:13 INFO - psutil == 3.1.1 20:00:13 INFO - requests == 1.2.3 20:00:13 INFO - wsgiref == 0.1.2 20:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:13 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:00:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 20:00:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:00:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:00:13 INFO - 'HOME': '/Users/cltbld', 20:00:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:00:13 INFO - 'LOGNAME': 'cltbld', 20:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:13 INFO - 'MOZ_NO_REMOTE': '1', 20:00:13 INFO - 'NO_EM_RESTART': '1', 20:00:13 INFO - 'PAGER': '/bin/cat', 20:00:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:13 INFO - 'PWD': '/builds/slave/test', 20:00:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:00:13 INFO - 'SHELL': '/bin/bash', 20:00:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 20:00:13 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:00:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:00:13 INFO - 'USER': 'cltbld', 20:00:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:00:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:13 INFO - 'XPC_FLAGS': '0x0', 20:00:13 INFO - 'XPC_SERVICE_NAME': '0', 20:00:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:00:13 INFO - Cleaning up... 20:00:13 INFO - Return code: 0 20:00:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:14 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 0x10d33db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d340768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8441dacaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, '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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 20:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:00:14 INFO - 'HOME': '/Users/cltbld', 20:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:00:14 INFO - 'LOGNAME': 'cltbld', 20:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:14 INFO - 'MOZ_NO_REMOTE': '1', 20:00:14 INFO - 'NO_EM_RESTART': '1', 20:00:14 INFO - 'PAGER': '/bin/cat', 20:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:14 INFO - 'PWD': '/builds/slave/test', 20:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:00:14 INFO - 'SHELL': '/bin/bash', 20:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 20:00:14 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:00:14 INFO - 'USER': 'cltbld', 20:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:14 INFO - 'XPC_FLAGS': '0x0', 20:00:14 INFO - 'XPC_SERVICE_NAME': '0', 20:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:00:14 INFO - Cleaning up... 20:00:14 INFO - Return code: 0 20:00:14 INFO - Running post-action listener: _resource_record_post_action 20:00:14 INFO - Running post-action listener: _start_resource_monitoring 20:00:14 INFO - Starting resource monitoring. 20:00:14 INFO - [mozharness: 2017-01-25 04:00:14.486061Z] Finished create-virtualenv step (success) 20:00:14 INFO - [mozharness: 2017-01-25 04:00:14.487035Z] Running install step. 20:00:14 INFO - Running pre-action listener: _resource_record_pre_action 20:00:14 INFO - Running main action method: install 20:00:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:14 INFO - Reading from file tmpfile_stdout 20:00:14 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:00:14 INFO - Reading from file tmpfile_stdout 20:00:14 INFO - Output received: 20:00:14 INFO - Usage: mozinstall [options] installer 20:00:14 INFO - Options: 20:00:14 INFO - -h, --help show this help message and exit 20:00:14 INFO - -d DEST, --destination=DEST 20:00:14 INFO - Directory to install application into. [default: 20:00:14 INFO - "/builds/slave/test"] 20:00:14 INFO - --app=APP Application being installed. [default: firefox] 20:00:14 INFO - mkdir: /builds/slave/test/build/application 20:00:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:00:36 INFO - Reading from file tmpfile_stdout 20:00:36 INFO - Output received: 20:00:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:00:36 INFO - Running post-action listener: _resource_record_post_action 20:00:36 INFO - [mozharness: 2017-01-25 04:00:36.778328Z] Finished install step (success) 20:00:36 INFO - [mozharness: 2017-01-25 04:00:36.778461Z] Running run-tests step. 20:00:36 INFO - Running pre-action listener: _resource_record_pre_action 20:00:36 INFO - Running main action method: run_tests 20:00:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:00:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:00:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:00:36 INFO - 2017-01-24 20:00:36.792 screenresolution[1912:15999] starting screenresolution argv=screenresolution get 20:00:36 INFO - 2017-01-24 20:00:36.795 screenresolution[1912:15999] Display 0: 1600x1200x32@60 20:00:36 INFO - 2017-01-24 20:00:36.800 screenresolution[1913:16001] starting screenresolution argv=screenresolution list 20:00:36 INFO - Available Modes on Display 0 20:00:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:00:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:00:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:00:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:00:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:00:37 INFO - Intel Iris: 20:00:37 INFO - Chipset Model: Intel Iris 20:00:37 INFO - Type: GPU 20:00:37 INFO - Bus: Built-In 20:00:37 INFO - VRAM (Dynamic, Max): 1536 MB 20:00:37 INFO - Vendor: Intel (0x8086) 20:00:37 INFO - Device ID: 0x0a2e 20:00:37 INFO - Revision ID: 0x0009 20:00:37 INFO - Displays: 20:00:37 INFO - Display: 20:00:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:00:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:00:37 INFO - Display Serial Number: 1600x1200 60 20:00:37 INFO - Main Display: Yes 20:00:37 INFO - Mirror: Off 20:00:37 INFO - Online: Yes 20:00:37 INFO - Rotation: Supported 20:00:37 INFO - Return code: 0 20:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:00:37 INFO - Python 2.7.3 20:00:37 INFO - Return code: 0 20:00:37 INFO - grabbing minidump binary from tooltool 20:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x10d11bd30>, '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 0x10d042db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d110be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:00:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:00:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:00:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:00:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:37 INFO - Return code: 0 20:00:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:00:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:00:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:00:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:00:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:00:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YiNeJTfvMt/Render', 20:00:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:00:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:00:37 INFO - 'HOME': '/Users/cltbld', 20:00:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:00:37 INFO - 'LOGNAME': 'cltbld', 20:00:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:00:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:37 INFO - 'MOZ_NO_REMOTE': '1', 20:00:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:00:37 INFO - 'NO_EM_RESTART': '1', 20:00:37 INFO - 'PAGER': '/bin/cat', 20:00:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:37 INFO - 'PWD': '/builds/slave/test', 20:00:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:00:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:00:37 INFO - 'SHELL': '/bin/bash', 20:00:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmwMD5EoPz/Listeners', 20:00:37 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:00:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:00:37 INFO - 'USER': 'cltbld', 20:00:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:00:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:37 INFO - 'XPC_FLAGS': '0x0', 20:00:37 INFO - 'XPC_SERVICE_NAME': '0', 20:00:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:00:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:00:37 INFO - mozversion application_buildid: 20170124184448 20:00:37 INFO - mozversion application_changeset: 36896a90b68cc4e3a9a7d3d18186d95d6a56d852 20:00:37 INFO - mozversion application_display_name: Nightly 20:00:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:37 INFO - mozversion application_name: Firefox 20:00:37 INFO - mozversion application_remotingname: firefox 20:00:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:00:37 INFO - mozversion application_vendor: Mozilla 20:00:37 INFO - mozversion application_version: 54.0a1 20:00:37 INFO - mozversion platform_buildid: 20170124184448 20:00:37 INFO - mozversion platform_changeset: 36896a90b68cc4e3a9a7d3d18186d95d6a56d852 20:00:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:00:37 INFO - mozversion platform_version: 54.0a1 20:00:37 INFO - using testdate: 1485316837 20:00:37 INFO - actual date: 1485316837 20:00:37 INFO - starting webserver on 'localhost:52477' 20:00:37 INFO - SUITE-START | Running 2 tests 20:00:37 INFO - TEST-START | dromaeo_css 20:00:37 INFO - operating with platform_type : mac_ 20:00:37 INFO - Initialising browser for dromaeo_css test... 20:00:37 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp7RMUb2/profile http://localhost:52477/getInfo.html) 20:00:39 INFO - PROCESS | 1923 | __metrics Screen width/height:1600/1200 20:00:39 INFO - PROCESS | 1923 | colorDepth:24 20:00:39 INFO - PROCESS | 1923 | Browser inner width/height: 1024/689 20:00:39 INFO - PROCESS | 1923 | __metrics 20:00:39 INFO - PROCESS | 1923 | 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" 20:00:39 INFO - PROCESS | 1923 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:40 INFO - TEST-INFO | 1923: exit 0 20:00:40 INFO - Browser initialized. 20:00:40 INFO - Running cycle 1/1 for dromaeo_css test... 20:00:40 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp7RMUb2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:52 INFO - PROCESS | 1925 | RSS: Main: 228032512 20:00:52 INFO - PROCESS | 1925 | 20:03:56 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52477/tests/dromaeo/cssquery-ext.html) 20:03:57 INFO - PROCESS | 1925 | RSS: Main: 384520192 20:03:57 INFO - PROCESS | 1925 | 20:05:42 INFO - PROCESS | 1925 | ************************* 20:05:42 INFO - PROCESS | 1925 | A coding exception was thrown and uncaught in a Task. 20:05:42 INFO - PROCESS | 1925 | 20:05:42 ERROR - PROCESS | 1925 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:05:42 INFO - PROCESS | 1925 | Full stack: 20:05:42 INFO - PROCESS | 1925 | ************************* 20:07:00 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-ext.html (next: http://localhost:52477/tests/dromaeo/cssquery-jquery.html) 20:07:01 INFO - PROCESS | 1925 | RSS: Main: 373534720 20:07:01 INFO - PROCESS | 1925 | 20:10:03 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52477/tests/dromaeo/cssquery-mootools.html) 20:10:04 INFO - PROCESS | 1925 | RSS: Main: 356425728 20:10:04 INFO - PROCESS | 1925 | 20:13:06 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52477/tests/dromaeo/cssquery-prototype.html) 20:13:07 INFO - PROCESS | 1925 | RSS: Main: 347480064 20:13:07 INFO - PROCESS | 1925 | 20:16:10 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52477/tests/dromaeo/cssquery-yui.html) 20:16:11 INFO - PROCESS | 1925 | RSS: Main: 333586432 20:16:11 INFO - PROCESS | 1925 | 20:19:14 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:52477/tests/dromaeo/cssquery-yui.html (next: http://localhost:52477/tests/dromaeo/cssquery-dojo.html) 20:19:15 INFO - PROCESS | 1925 | RSS: Main: 381710336 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | __start_tp_report 20:19:15 INFO - PROCESS | 1925 | _x_x_mozilla_page_load 20:19:15 INFO - PROCESS | 1925 | _x_x_mozilla_page_load_details 20:19:15 INFO - PROCESS | 1925 | |i|pagename|runs| 20:19:15 INFO - PROCESS | 1925 | |0;dojo.html;2741.945161096778;2815.7747380209585;3130.4678204705197;3239.4816829307315;3371.6628337166303;5567.276254086963;5599.41206173352;5753.993051216036;5775.364709881915;5786;5641.041023026085;5691.8292451226525;5759.5968282220265;5880.617759845607;5886.4702176804185;5117.513836185556;5172;5178.430372659023;5190.532852043315;5273.367195936474;5135.537801597856;5273.789048438058;5291.867703307429;5339.466053394668;5393;5114.872128196825;5280.498352656491;5281.498257665516;5307.044731948267;5331.653442526223;5167.199084141964;5170.922436163461;5228.215767634847;5228.2680424740565;5237.973810130963;5169.81905633301;5207.9479205207845;5219.034478621467;5219.817306394258;5230.8692282692855;5626.634268772516;5706.942930570683;5722.54219662426;5727.971360143172;5732.8853422931725;6154.907676384858;6222.657753823538;6246.750129994794;6288.748450061992;6299.590526615755;6276.246850377984;6277.497800175975;6283.183186185813;6295.716692748837;6314.87370252597;5727.3699893011735;5748.885022299531;5846.41535846412;5903.468687818074;5910.645361278294;6207.503399728011;6258.718357673915;6278.215223097113;6278.434940855345;6324.620522768649;6179.412955769195;6199.473044791153;6209.875802483925;6222.12890195373;6242.250929888442;6281.937180628227;6291.150694656254;6307.4954003679595;6313.810585682437;6314.17915670969;6100.115483254903;6130.172426722335;6143.262808463013;6160.1375807387;6171;6201.193844800147;6282.246130464374;6293.3391993840905;6293.496520278367;6297.685115744194;4968.677035992649;5007.173816320266;5023.899522009539;5034.345535080416;5047.242913562922;3751.81240937952;3940.9211815763524;4376.540463251376;4461.174682683714;4484.977575112103;5660.603757736919;5718;5727.2268243787385;5755.59710820247;5767.538596912321;5780.335261444988;6321.810345689637;6333.936660633427;6356.4279214870885;6366.236051673829;5725.770969161187;5781.248437703071;5795.94204057954;5798.594098413155;5866.823995280149;5374.381946076173;5451.918221226685;5494.478024587658;5499.230107784913;5534.391216966131;6235.968820155961;6260.029695397221;6267.937320626917;6269.435750782452;6380.680965951777;6155.538334625011;6263.592866463665;6268.153799237227;6279.152314437492;6296.2759282681245;6304.65324407162;6322.272938612118;6366.4588509977175;6384.585001975042;6385.138006369267;6105.572609917263;6111.7132884518705;6150.954337762681;6155;6197.876042479035;6257.7184026718;6269.153664255267;6269.874602508015;6284.4344009039405;6300.527460440394;4666.696664716783;5421.756020978986;6116.755329786936;6165.445109940127;6206.317305096526;5993.490553303018;6036.607620504653;6103.938960610337;6108.236470441195;6112.908306375319;6019.097135429545;6074.665893375906;6081.6351018939;6090.69546522681;6115.449609535163;5996.400359963969;6036.6679832609625;6199.225096862892;6209.844753881009;6253.7185826637;5934.910976335272;5966.582339236212;5990.850228744316;6010.669413182317;6112.816615501542 20:19:15 INFO - PROCESS | 1925 | |1;ext.html;450.961668258198;458.17528448792166;463.03457291547124;468.28586405731255;492.41402730750406;29705.851470742644;31678.208044798892;37752.81123594385;39103.60896391035;39155.41266880999;41354.7932260339;41847;41850.372244416285;41852.37221441673;41982;8568.97172339317;9180.311476639228;9302.20931220847;9324.906750932505;9401.717948461523;8411.453255538401;8607.741767746978;9368.484733339663;11061.668149955514;11360.48877800501;11299.548018079267;11335.263207891501;11344.319340839576;11350.035247004014;11381.2033157679;11184.496697648545;11284.266522676;11322.886771132265;11363.090952723762;11423.5430582777;8294.3779216559;8500.532470714108;11098.44507774616;11247.83128253077;11371.431428428628;39882.202355952715;40258.59741402607;40275.99310017244;40286;40335.7983210085;3955.861544845917;3971.5631280559114;3985.183037477339;4019.4774679291504;4085.7957102144774;29617.555736663966;30417.847910760527;30574.847125764452;30828.845855770578;30877.382452350826;3126.937461250762;3271.39701546243;3274.5579346788354;3280.9671903281137;3312.254742682901;476955.9999999965;482696;482890;482945;484593;59540.70229648824;59974;59979.100313495335;60122.69938650279;60199.796004079675;60347.69826150841;62403;62595.6870215646;62644;62711.372886270554;15213;15764.842351576337;15779;15788;15789.447369342019;11546.884531154748;11554.191206615456;11562.537498499965;11567.42162891852;11568.652940411801;13570.05009649315;13877.236751978537;13919.304034798219;15485.690286194213;15768.684626307639;6453.838654033593;6474.643894585843;7055.400290975324;7098.36114749675;7114.217436082027;776.984460310802;861.4615865084322;880.9427387219811;881.9717232714341;914.9405288656216;28510.42979140447;29514.55728164079;29573.112806615834;30187.69812301849;30619.38761224763;1041.833306670929;1057.1912486947492;1057.281048886749;1085.1969542538623;1091.4379094766202;12678.492860285669;14813.407463701331;15071.924640376728;15154.772678409832;15598.766018509732;611242;616149;616730;616826;617426;59967.70016149891;59991.10013349716;60005.69997149986;60257.69871150704;60373;1395.6859706565942;1418.560246323643;1430.5565274764856;1432.6060333408188;1434.763264061439;28075.0173743918;28752.281192970342;28880.956666066348;29477.557836632037;29773.80904763872;47342.76328618335;47347;47446.76276618595;47471;47476.100955961374;522816;526108.738912606;526665;526947;528574.7853953869;25583.848726806966;25867.353316167246;25875.964961402085;25883.482330352912;25941.481170376108;46253.53746462627;46972.29541556811;47079.82300442516;47508;47663.76168119276;37965.430518542795;38321.4251786229;38386.61613383942;39206;39332.606673932896;36431.99248082762;37964;38204.42693359546;38660;38860.41709374305;33683.831580841936;37363;37816.43275350817;37909;38087.80956095202;27770;30897.073087807403;31156.37687246288;31186.376272474878;31439.84280078585;23430.64854027225;23642.763572364056;23831.614691268773;23989.400264993514;24000.51998960046 20:19:15 INFO - PROCESS | 1925 | |2;jquery.html;374.8275793135161;395.8317714971137;397.4376257595501;406.3620116417225;426.61391440746115;14342.928285358572;15842;19153.61692766144;19490.63565550412;21614.459638509044;20376.388708338738;21699.240526581572;22483.887580562114;22648;22816.31551053471;4903.411590609123;5779.335376431701;5958.553108516857;6026.126211699301;6102.816915492543;4249.532551419341;5319.680819150844;5669.489745922866;5971.37300583439;5976;4436.401085853401;6321.525885558579;6600.603963762165;6652.268250492466;6732.663366831664;6456.515761317873;6615.702293396808;6706.2287836898895;6722.563033402813;6729.125213722234;5858.882822343529;5859.1504231886565;5861;5862.853428664317;5868.119782032687;21926.684398935955;25810;26254.47491050168;26424.60363094536;26543.73456265432;2128.5423633918626;2730.959035614467;2762.323230808445;2766.8201566898088;2775.1674497650824;15844.28700708471;15980.4406845761;16094.195290235559;16199.838001619952;16879;1816.6911625023777;1843.5988648627006;1853.379117995473;1856.4152292027968;1925.7689077310672;88340.6748898767;104691.42962855563;110743.33884991732;120710.79289207084;120824;10999.670009899715;11076.169287303484;11397;11521;11530.423478826026;14033.368498417596;14040;14454.783178252335;14520.927395363167;14522.564323070324;8434.072252052269;8686.913130868737;8688.39181257306;8819.647214111492;8827.779305517413;8511.53186574732;8546.871796923051;8583.313334933191;8740.21338079576;8780.253678437404;7087.782769252287;7230.204142825059;7237.240089790602;7245.384142347854;7257.564546127249;1624.350259896051;1892.687706528435;1931.169597073244;1937.2154277517627;1938.195648805758;819.8360327934317;1017.867677201959;1021.1320377678913;1044.9425281609585;1106.9612563560236;17451.30194792194;19433.805661943483;22693.773062269494;23343.53312933766;23356.299311020695;938.957746901391;1004.0311099788739;1074.3714926767927;1124.2130508643982;1126.099120703434;11293.94353028246;11950.70148673313;12044.759104817855;12143.635690929286;12186.695332616579;677593;678631;680430;692845;709417;103286.35239176579;114400.1279833633;114712;118908;135366;760.627292626609;1007.8992100790009;1037.9792404151874;1040.2926010312908;1042.3485321673954;20848.58302833965;21512;21520.89239553792;21562.568748624624;21700.34898953034;55685;55686.72156639191;56431.15353269786;56840.71579642075;57745.422545774;79554;80714.38571228425;81340.18659813327;81993.59003204945;86423.2715345677;5559.777608895761;5650.491455769001;5663.830085097454;8061.919380806117;8127.431079824356;13432.529861454803;13452.596422107352;13539.729205416033;13922.955778316464;13998.880089593013;10360.740981475223;10531.420771857314;11475.368854713071;11783.88216117862;11892.286462812259;11180.608678696206;11208.551657933918;11212.822653621579;11389.715257118638;12040.531691003498;8148;11553.422328883691;11836.408179591159;11845.289282643069;11904.642860714192;8041.195880411912;8275;8316;8317.376196785386;8463.069062403254;11548;11622.825657614974;11963.700907477383;11985.580504682293;12030.09774266916 20:19:15 INFO - PROCESS | 1925 | |3;mootools.html;1457.2276693352526;1460.277162804412;1472.734907716611;1484.4730120807105;1488.3451281436164;7941.245581669747;8342.95828520858;8347.83304333913;8363.20549547792;8367.832643347137;7476.401887848972;7679.347255483291;7689.307962283393;7931.8413631727335;8217.506949583028;2258.898349574265;2312.456572705413;2314.4445333120098;2315.8610483370967;2315.918942837001;2299.4251437140715;2323.465602911331;2330.8368414211013;2342.2973108067595;2342.6603142544323;2268.9886550567226;2283.9200627978025;2291.86248825071;2317.9884100579475;2323.2913961241898;2268.7731226877345;2271.5229801741652;2296.3455415206586;2306.273523839985;2308.3421224950976;1973.8223559879536;2250.054976909702;2320.4082958845556;2328.406256404623;2336.030547322859;8296.377771667148;8365.24712775847;8378.03652579955;8384.8742268866;8432.241098301121;5037.143685573425;5189.974050129763;5191.506806853343;5195.220716892459;5195.947600697703;3257.1368587324378;3347.681970212826;3548.7515873888838;3550.7869527828157;3556.05764472415;1022.8977102289786;1202.9338386388745;1234.6913271682079;1234.9012079033655;1256.2525297448094;10646.414447205401;10741.462926853626;10742.3017503862;10746.140308775279;10759.408232547206;4377.146456441027;4612.815487380467;4638.930416043762;4692.436907571113;4694.413198350207;9273.397229180082;9342.299327550461;9372.1565059145;9374.062593740708;9395.060493950687;5207.427183009866;5214.0875346814155;5222.242774797709;5224.8171314004585;5225.712585807741;4207.600277973587;4225.556316586714;4689.226277664216;4708.741019243906;4782.641301902371;3742.401215805458;3758;3841.8463261469788;3844.6539811417106;3891.571927088018;1251.8622951475331;1272.4719241514667;1273.611548477723;1285.7235694325766;1287.0540152987546;774.4230548241484;845.9848182181407;907.396581273459;911.2709832134266;940.8024314893812;5479.780808767605;5481.150421684645;5633.521150702154;5790.536757059425;5802.506786923159;965.6475386483883;990.9851352229722;991.8611394404645;1006.2654262388497;1040.4433628008978;3669.284489524517;3684.3184010958057;3696.1334526064165;3794.487744154559;3795.867144649924;9657.565409556446;9936.453495057696;9966.302358834811;9970.252231082697;9974.950125249326;9836.557354919047;9908.900910990798;9930.553125109387;9933.602655893828;9937.602495900228;7632.389408847279;7685.42359323053;7759.767206983686;7771.961140194263;7772.417068719868;4740.9051818962735;4799.688020278671;4932.556069953722;4934.111859865258;5072.061668591323;8875.600597972978;9117.08829117083;9163.175314221751;9215.76960575991;9235.399699019543;9139.177474027369;9330.020347863376;9414.670486533212;9455.479948602893;9465.574049167943;6655.201375834931;6682.599044057372;6689.431398331197;6802.455803535804;6803.25164231944;7742.845143097219;7820.491668041559;7835.5690437026515;7841.137474877873;7851.960740196491;6845.691943862637;7048.330408611174;7073.858522829618;7098.396636285974;7161.713531458683;6863.933546630742;6908.44732421395;6923.8961415579815;7009.614471204132;7032.980217868483;6324.083007963727;6336.20797400325;6385.904211436739;6414.807555773335;6419.037144428186;4830.565249127595;4873.4639189689815;4914.606831453403;4923.926141107958;5020.598352131894;4616.653750968623;4911.165101932608;4978.253262010582;5019.598432125348;5035.924461133012 20:19:15 INFO - PROCESS | 1925 | |4;prototype.html;331.3555135261916;354.0723304941055;364.28418158318897;372.7130109815444;374.8051013472994;4652.837150699726;5372;5384.876771472546;5404.48657377549;5414.756335964886;4799.496052914437;4987.650864439482;5072.442031376546;5115.846524604259;5207.7916883324715;3415.419378705626;4061.6547593454593;4117.794110294488;4143.606357396043;4155.667546596265;3484.756067075306;3994.8801535953967;4102.620480121523;4145.212409642173;4147.460830092084;3642.3079614873222;3712.5544934607883;3918.294706952747;4101.79491025449;4149.792510374485;3746.138388170709;3805.238952209569;4061.4923134608175;4105.815238314268;4110.7328023678365;3594.813711475207;3602.676787854559;3606.6934310583633;3613.6386361363916;3614.1868079681863;4826.32431459596;5098.362704661918;5118.513741194581;5125.871853203663;5151;3831.8084095795098;4542.160425027836;4555.954440455619;4592.862214133581;4597.42532183477;5585.2459917910965;5606.785689308941;5613.46672066153;5619.8595035124445;5639.379668236491;3321.7674762766615;3604.7203242848936;3810.8856734298015;3831.2337532493334;3831.291211125923;5322.467753224647;5461.3785383016375;5783.397471137962;5820.272465941757;5825.135956493924;3831.233753249361;3839.9040023999623;3840.5967373425387;3848.0956975110826;3863.690904727615;3884.6309600587897;3889.7082718796205;3890.455336252927;3899.941500877489;3906.3945088511327;4337.443296496842;4531.410916580823;4556.453225612948;4598.793054312564;4615.3999980003055;4923.359963204832;5403.8108666196495;5575.414581468968;5577.123898890313;5674.517665998354;1204.6325870609548;1252.136026141959;1257.251935098615;1259.6535952613106;1274.8278982337265;742.1465314887814;787.696736756353;810.8621534339177;824.9505029698238;858.6393714639867;4321.558319549445;4794.202174184681;4865.3701010161285;4880;4880.55972013993;5135.845924622267;5139.717315547681;5357.785688572491;5399;5459.645123066988;4369.71596846204;4507.639388848885;4800.831970881002;4846.39420072491;4877.317175595419;2228.286948176568;2544.849602086234;2824.56219286011;2828.533292006837;2841.829490230593;4543.159515489645;5483.8080667176455;5544.417836127229;5568.303962004749;5607.663540187602;4695.624350051988;4894.070126675921;5424.484673955968;5541.445855414427;5614.6805500707305;5030.37120359955;5367.819079802437;5417.020638648806;5581.441855814386;5620.409856965041;4762.78567464458;5328.682023319869;5371.677699337896;5411.458854114557;5435.809746658848;5031.270465782368;5678.914816277842;5704.743286552032;5709.314882214161;5746.511546518593;5250.343707036621;5366.490183432567;5933.884710527008;6001.109650460091;6027.638341699512;3928.9981054830837;4012.53855806586;4186.455760751083;4199.2441360555395;4207.368894665825;4662.927526668817;5193.75349916025;5519.1234980105355;5781.046127388934;5794.333651630117;5058.3929928408825;5073.34046573943;5292.867678307919;5561.888762224814;5662.2639056922335;4893.632977526629;5560.277163968658;5597.788873395068;5626.5780066496;5648.689322087324;4693.929591056205;5067.46791586878;5080.949190508048;5189.532942035235;5486.588505861996;5088;5224.608154388512;5416.75624596902;5455.381416919821;5512.972435137799;5067.239914012927;5485.698286594116;5515.834524964257;5536.871667507845;5544.63959842609 20:19:15 INFO - PROCESS | 1925 | |5;yui.html;613.2150846915944;703.2650879830579;767.973120940767;773.6363908962785;837.9748607541774;14842.77735833962;15761.527154185364;15781.526554203378;15792.131432771193;15799.052056876595;14063.296835158228;14205.857941420583;14351.28243587819;14567.417303307855;14599.854001459982;681.9727210911558;702.0382076555101;703.1737708192878;852.7825404521869;862.3704695572236;873.6199753107387;876.8553188723885;878.9560521973875;879.0725784297564;880.7049638371153;927.0405130689737;945.5697657565792;948.340903072365;948.5921053946801;949.8242825077348;782.6517199846071;936.9390989585723;938.9342746007782;942.105000249762;942.1567696911295;529.1110933631497;546.1180193986722;672.5426709837309;696.853660731247;697.2191145916555;14747.262636868114;15315.923420382938;15320.923395383063;15347.232638368037;15356;13697.794533082011;13698.589042328746;13705.177689338572;13763.38064787087;13785.310734463237;10912;12421.254724716546;12595.181313214704;12657.683557911034;12687.302198379086;3951.5060617422823;4399.846005389828;4412.624926881219;4574.290984897346;4635.2120139576355;112770;114593;114888;116850.41574792156;118131.81868181295;10704.30422022566;10835.295705779099;10870.565177392815;11212.607558735404;11388.772224555629;17674.646507070043;21202.78797212039;21304.36086917395;21436.24973125933;21460.78539214619;7663.578503182379;7678.616069196518;7717;7730.226977302337;7773.989381380385;3527.664871837171;4258.765767882796;4311.2239796836875;4384.079343337935;4436.0906014267;3359.714424273915;3426.5716785401823;3436.742244331685;3452.637473065292;3458.342914846171;655.0469067506766;658.3712554510431;671.6977360187935;705.5801797930224;707.6850801393331;503.7833731495492;607.1590846677384;631.57999930046;658.8601719026111;662.5494663628779;9074.682386116454;10825.26795712698;11135.888641113484;11409;11438.026113210459;478.3327258474409;565.4571611253243;595.8391234366696;638.0142679560091;684.8356394465293;4586.334981427741;5057.241413787888;5058.822941197041;5062.240663900445;5069.138246498031;73852;95544;97123.51438242904;97137;99931.00068999363;85318.14681853226;87914;89146.10853891508;89394.55302723445;90963;74344;77510.6124469374;81163;82702;84235;8626.568671566522;11087.611933582286;11149.498272577592;11201.719957000814;11354.94322528415;53023.46976530185;53766;54264;55056.0730374435;55797.978181963816;57624.423755761905;70617;71389.64305178648;73290;75286.62356688401;13415.396307166005;13796.586102416944;13804.654883627989;13905.37425815861;14404.99165058436;13309.800352994907;13384.93307533456;13394.93302533481;13404.416605158473;13427.798583021458;11914.67815675437;13938.721225575635;13979.650508737363;14368.353424096149;14564;13380;13541.796873046715;13659.04386692922;13932.651683707989;14047.227402492961;12860.614181574567;13022.088453808521;13373.598792036255;13718.93140534291;13783.310834458036;11351.829722554334;11363.943180284046;11627.583327534605;11734.882651173379;12009.159358845147;8941.865872011795;10983.231173817756;10987.340759554452;11177.944110279397;11223.66329010131 20:19:15 INFO - PROCESS | 1925 | __end_tp_report 20:19:15 INFO - PROCESS | 1925 | __start_cc_report 20:19:15 INFO - PROCESS | 1925 | _x_x_mozilla_cycle_collect,1465 20:19:15 INFO - PROCESS | 1925 | __end_cc_report 20:19:15 INFO - PROCESS | 1925 | __startTimestamp1485317955206__endTimestamp 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | ------- Summary: start ------- 20:19:15 INFO - PROCESS | 1925 | Number of tests: 6 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | [#0] dojo.html Cycles:165 Average:5748.32 Median:5996.40 stddev:698.31 (11.6%) stddev-sans-first:659.42 20:19:15 INFO - PROCESS | 1925 | Values: 2741.9 2815.8 3130.5 3239.5 3371.7 5567.3 5599.4 5754.0 5775.4 5786.0 5641.0 5691.8 5759.6 5880.6 5886.5 5117.5 5172.0 5178.4 5190.5 5273.4 5135.5 5273.8 5291.9 5339.5 5393.0 5114.9 5280.5 5281.5 5307.0 5331.7 5167.2 5170.9 5228.2 5228.3 5238.0 5169.8 5207.9 5219.0 5219.8 5230.9 5626.6 5706.9 5722.5 5728.0 5732.9 6154.9 6222.7 6246.8 6288.7 6299.6 6276.2 6277.5 6283.2 6295.7 6314.9 5727.4 5748.9 5846.4 5903.5 5910.6 6207.5 6258.7 6278.2 6278.4 6324.6 6179.4 6199.5 6209.9 6222.1 6242.3 6281.9 6291.2 6307.5 6313.8 6314.2 6100.1 6130.2 6143.3 6160.1 6171.0 6201.2 6282.2 6293.3 6293.5 6297.7 4968.7 5007.2 5023.9 5034.3 5047.2 3751.8 3940.9 4376.5 4461.2 4485.0 5660.6 5718.0 5727.2 5755.6 5767.5 5780.3 6321.8 6333.9 6356.4 6366.2 5725.8 5781.2 5795.9 5798.6 5866.8 5374.4 5451.9 5494.5 5499.2 5534.4 6236.0 6260.0 6267.9 6269.4 6380.7 6155.5 6263.6 6268.2 6279.2 6296.3 6304.7 6322.3 6366.5 6384.6 6385.1 6105.6 6111.7 6151.0 6155.0 6197.9 6257.7 6269.2 6269.9 6284.4 6300.5 4666.7 5421.8 6116.8 6165.4 6206.3 5993.5 6036.6 6103.9 6108.2 6112.9 6019.1 6074.7 6081.6 6090.7 6115.4 5996.4 6036.7 6199.2 6209.8 6253.7 5934.9 5966.6 5990.9 6010.7 6112.8 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | [#1] ext.html Cycles:180 Average:67416.48 Median:38146.12 stddev:145262.90 (380.8%) stddev-sans-first:145583.39 20:19:15 INFO - PROCESS | 1925 | Values: 451.0 458.2 463.0 468.3 492.4 29705.9 31678.2 37752.8 39103.6 39155.4 41354.8 41847.0 41850.4 41852.4 41982.0 8569.0 9180.3 9302.2 9324.9 9401.7 8411.5 8607.7 9368.5 11061.7 11360.5 11299.5 11335.3 11344.3 11350.0 11381.2 11184.5 11284.3 11322.9 11363.1 11423.5 8294.4 8500.5 11098.4 11247.8 11371.4 39882.2 40258.6 40276.0 40286.0 40335.8 3955.9 3971.6 3985.2 4019.5 4085.8 29617.6 30417.8 30574.8 30828.8 30877.4 3126.9 3271.4 3274.6 3281.0 3312.3 476956.0 482696.0 482890.0 482945.0 484593.0 59540.7 59974.0 59979.1 60122.7 60199.8 60347.7 62403.0 62595.7 62644.0 62711.4 15213.0 15764.8 15779.0 15788.0 15789.4 11546.9 11554.2 11562.5 11567.4 11568.7 13570.1 13877.2 13919.3 15485.7 15768.7 6453.8 6474.6 7055.4 7098.4 7114.2 777.0 861.5 880.9 882.0 914.9 28510.4 29514.6 29573.1 30187.7 30619.4 1041.8 1057.2 1057.3 1085.2 1091.4 12678.5 14813.4 15071.9 15154.8 15598.8 611242.0 616149.0 616730.0 616826.0 617426.0 59967.7 59991.1 60005.7 60257.7 60373.0 1395.7 1418.6 1430.6 1432.6 1434.8 28075.0 28752.3 28881.0 29477.6 29773.8 47342.8 47347.0 47446.8 47471.0 47476.1 522816.0 526108.7 526665.0 526947.0 528574.8 25583.8 25867.4 25876.0 25883.5 25941.5 46253.5 46972.3 47079.8 47508.0 47663.8 37965.4 38321.4 38386.6 39206.0 39332.6 36432.0 37964.0 38204.4 38660.0 38860.4 33683.8 37363.0 37816.4 37909.0 38087.8 27770.0 30897.1 31156.4 31186.4 31439.8 23430.6 23642.8 23831.6 23989.4 24000.5 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | [#2] jquery.html Cycles:180 Average:37578.24 Median:22205.29 stddev:113666.00 (511.9%) stddev-sans-first:113950.54 20:19:15 INFO - PROCESS | 1925 | Values: 374.8 395.8 397.4 406.4 426.6 14342.9 15842.0 19153.6 19490.6 21614.5 20376.4 21699.2 22483.9 22648.0 22816.3 4903.4 5779.3 5958.6 6026.1 6102.8 4249.5 5319.7 5669.5 5971.4 5976.0 4436.4 6321.5 6600.6 6652.3 6732.7 6456.5 6615.7 6706.2 6722.6 6729.1 5858.9 5859.2 5861.0 5862.9 5868.1 21926.7 25810.0 26254.5 26424.6 26543.7 2128.5 2731.0 2762.3 2766.8 2775.2 15844.3 15980.4 16094.2 16199.8 16879.0 1816.7 1843.6 1853.4 1856.4 1925.8 88340.7 104691.4 110743.3 120710.8 120824.0 10999.7 11076.2 11397.0 11521.0 11530.4 14033.4 14040.0 14454.8 14520.9 14522.6 8434.1 8686.9 8688.4 8819.6 8827.8 8511.5 8546.9 8583.3 8740.2 8780.3 7087.8 7230.2 7237.2 7245.4 7257.6 1624.4 1892.7 1931.2 1937.2 1938.2 819.8 1017.9 1021.1 1044.9 1107.0 17451.3 19433.8 22693.8 23343.5 23356.3 939.0 1004.0 1074.4 1124.2 1126.1 11293.9 11950.7 12044.8 12143.6 12186.7 677593.0 678631.0 680430.0 692845.0 709417.0 103286.4 114400.1 114712.0 118908.0 135366.0 760.6 1007.9 1038.0 1040.3 1042.3 20848.6 21512.0 21520.9 21562.6 21700.3 55685.0 55686.7 56431.2 56840.7 57745.4 79554.0 80714.4 81340.2 81993.6 86423.3 5559.8 5650.5 5663.8 8061.9 8127.4 13432.5 13452.6 13539.7 13923.0 13998.9 10360.7 10531.4 11475.4 11783.9 11892.3 11180.6 11208.6 11212.8 11389.7 12040.5 8148.0 11553.4 11836.4 11845.3 11904.6 8041.2 8275.0 8316.0 8317.4 8463.1 11548.0 11622.8 11963.7 11985.6 12030.1 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | [#3] mootools.html Cycles:180 Average:5377.40 Median:5195.58 stddev:2923.90 (56.3%) stddev-sans-first:2917.26 20:19:15 INFO - PROCESS | 1925 | Values: 1457.2 1460.3 1472.7 1484.5 1488.3 7941.2 8343.0 8347.8 8363.2 8367.8 7476.4 7679.3 7689.3 7931.8 8217.5 2258.9 2312.5 2314.4 2315.9 2315.9 2299.4 2323.5 2330.8 2342.3 2342.7 2269.0 2283.9 2291.9 2318.0 2323.3 2268.8 2271.5 2296.3 2306.3 2308.3 1973.8 2250.1 2320.4 2328.4 2336.0 8296.4 8365.2 8378.0 8384.9 8432.2 5037.1 5190.0 5191.5 5195.2 5195.9 3257.1 3347.7 3548.8 3550.8 3556.1 1022.9 1202.9 1234.7 1234.9 1256.3 10646.4 10741.5 10742.3 10746.1 10759.4 4377.1 4612.8 4638.9 4692.4 4694.4 9273.4 9342.3 9372.2 9374.1 9395.1 5207.4 5214.1 5222.2 5224.8 5225.7 4207.6 4225.6 4689.2 4708.7 4782.6 3742.4 3758.0 3841.8 3844.7 3891.6 1251.9 1272.5 1273.6 1285.7 1287.1 774.4 846.0 907.4 911.3 940.8 5479.8 5481.2 5633.5 5790.5 5802.5 965.6 991.0 991.9 1006.3 1040.4 3669.3 3684.3 3696.1 3794.5 3795.9 9657.6 9936.5 9966.3 9970.3 9975.0 9836.6 9908.9 9930.6 9933.6 9937.6 7632.4 7685.4 7759.8 7772.0 7772.4 4740.9 4799.7 4932.6 4934.1 5072.1 8875.6 9117.1 9163.2 9215.8 9235.4 9139.2 9330.0 9414.7 9455.5 9465.6 6655.2 6682.6 6689.4 6802.5 6803.3 7742.8 7820.5 7835.6 7841.1 7852.0 6845.7 7048.3 7073.9 7098.4 7161.7 6863.9 6908.4 6923.9 7009.6 7033.0 6324.1 6336.2 6385.9 6414.8 6419.0 4830.6 4873.5 4914.6 4923.9 5020.6 4616.7 4911.2 4978.3 5019.6 5035.9 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | [#4] prototype.html Cycles:180 Average:4453.72 Median:4955.51 stddev:1348.05 (27.2%) stddev-sans-first:1315.84 20:19:15 INFO - PROCESS | 1925 | Values: 331.4 354.1 364.3 372.7 374.8 4652.8 5372.0 5384.9 5404.5 5414.8 4799.5 4987.7 5072.4 5115.8 5207.8 3415.4 4061.7 4117.8 4143.6 4155.7 3484.8 3994.9 4102.6 4145.2 4147.5 3642.3 3712.6 3918.3 4101.8 4149.8 3746.1 3805.2 4061.5 4105.8 4110.7 3594.8 3602.7 3606.7 3613.6 3614.2 4826.3 5098.4 5118.5 5125.9 5151.0 3831.8 4542.2 4556.0 4592.9 4597.4 5585.2 5606.8 5613.5 5619.9 5639.4 3321.8 3604.7 3810.9 3831.2 3831.3 5322.5 5461.4 5783.4 5820.3 5825.1 3831.2 3839.9 3840.6 3848.1 3863.7 3884.6 3889.7 3890.5 3899.9 3906.4 4337.4 4531.4 4556.5 4598.8 4615.4 4923.4 5403.8 5575.4 5577.1 5674.5 1204.6 1252.1 1257.3 1259.7 1274.8 742.1 787.7 810.9 825.0 858.6 4321.6 4794.2 4865.4 4880.0 4880.6 5135.8 5139.7 5357.8 5399.0 5459.6 4369.7 4507.6 4800.8 4846.4 4877.3 2228.3 2544.8 2824.6 2828.5 2841.8 4543.2 5483.8 5544.4 5568.3 5607.7 4695.6 4894.1 5424.5 5541.4 5614.7 5030.4 5367.8 5417.0 5581.4 5620.4 4762.8 5328.7 5371.7 5411.5 5435.8 5031.3 5678.9 5704.7 5709.3 5746.5 5250.3 5366.5 5933.9 6001.1 6027.6 3929.0 4012.5 4186.5 4199.2 4207.4 4662.9 5193.8 5519.1 5781.0 5794.3 5058.4 5073.3 5292.9 5561.9 5662.3 4893.6 5560.3 5597.8 5626.6 5648.7 4693.9 5067.5 5080.9 5189.5 5486.6 5088.0 5224.6 5416.8 5455.4 5513.0 5067.2 5485.7 5515.8 5536.9 5544.6 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - PROCESS | 1925 | [#5] yui.html Cycles:180 Average:20742.61 Median:4347.65 stddev:29779.77 (685.0%) stddev-sans-first:29824.96 20:19:15 INFO - PROCESS | 1925 | Values: 613.2 703.3 768.0 773.6 838.0 14842.8 15761.5 15781.5 15792.1 15799.1 14063.3 14205.9 14351.3 14567.4 14599.9 682.0 702.0 703.2 852.8 862.4 873.6 876.9 879.0 879.1 880.7 927.0 945.6 948.3 948.6 949.8 782.7 936.9 938.9 942.1 942.2 529.1 546.1 672.5 696.9 697.2 14747.3 15315.9 15320.9 15347.2 15356.0 13697.8 13698.6 13705.2 13763.4 13785.3 10912.0 12421.3 12595.2 12657.7 12687.3 3951.5 4399.8 4412.6 4574.3 4635.2 112770.0 114593.0 114888.0 116850.4 118131.8 10704.3 10835.3 10870.6 11212.6 11388.8 17674.6 21202.8 21304.4 21436.2 21460.8 7663.6 7678.6 7717.0 7730.2 7774.0 3527.7 4258.8 4311.2 4384.1 4436.1 3359.7 3426.6 3436.7 3452.6 3458.3 655.0 658.4 671.7 705.6 707.7 503.8 607.2 631.6 658.9 662.5 9074.7 10825.3 11135.9 11409.0 11438.0 478.3 565.5 595.8 638.0 684.8 4586.3 5057.2 5058.8 5062.2 5069.1 73852.0 95544.0 97123.5 97137.0 99931.0 85318.1 87914.0 89146.1 89394.6 90963.0 74344.0 77510.6 81163.0 82702.0 84235.0 8626.6 11087.6 11149.5 11201.7 11354.9 53023.5 53766.0 54264.0 55056.1 55798.0 57624.4 70617.0 71389.6 73290.0 75286.6 13415.4 13796.6 13804.7 13905.4 14405.0 13309.8 13384.9 13394.9 13404.4 13427.8 11914.7 13938.7 13979.7 14368.4 14564.0 13380.0 13541.8 13659.0 13932.7 14047.2 12860.6 13022.1 13373.6 13718.9 13783.3 11351.8 11363.9 11627.6 11734.9 12009.2 8941.9 10983.2 10987.3 11177.9 11223.7 20:19:15 INFO - PROCESS | 1925 | -------- Summary: end -------- 20:19:15 INFO - PROCESS | 1925 | 20:19:15 INFO - TEST-INFO | 1925: exit 0 20:19:15 INFO - TEST-OK | dromaeo_css | took 1118471ms 20:19:15 INFO - TEST-START | kraken 20:19:15 INFO - operating with platform_type : mac_ 20:19:15 INFO - Initialising browser for kraken test... 20:19:15 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpwcr6kp/profile http://localhost:52477/getInfo.html) 20:19:18 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 20:19:18 INFO - PROCESS | 1930 | colorDepth:24 20:19:18 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 20:19:18 INFO - PROCESS | 1930 | __metrics 20:19:18 INFO - PROCESS | 1930 | 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" 20:19:18 INFO - PROCESS | 1930 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:18 INFO - TEST-INFO | 1930: exit 0 20:19:18 INFO - Browser initialized. 20:19:18 INFO - Running cycle 1/1 for kraken test... 20:19:18 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpwcr6kp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:30 INFO - PROCESS | 1931 | RSS: Main: 235782144 20:19:30 INFO - PROCESS | 1931 | 20:19:33 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:34 INFO - PROCESS | 1931 | RSS: Main: 288903168 20:19:34 INFO - PROCESS | 1931 | 20:19:37 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-dft) 20:19:37 INFO - PROCESS | 1931 | RSS: Main: 290164736 20:19:37 INFO - PROCESS | 1931 | 20:19:40 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-fft) 20:19:41 INFO - PROCESS | 1931 | RSS: Main: 380149760 20:19:41 INFO - PROCESS | 1931 | 20:19:43 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52477/tests/kraken/driver.html?testName=audio-oscillator) 20:19:44 INFO - PROCESS | 1931 | RSS: Main: 282533888 20:19:44 INFO - PROCESS | 1931 | 20:19:46 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:46 INFO - PROCESS | 1931 | RSS: Main: 286105600 20:19:46 INFO - PROCESS | 1931 | 20:19:49 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52477/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:50 INFO - PROCESS | 1931 | RSS: Main: 327921664 20:19:50 INFO - PROCESS | 1931 | 20:19:53 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52477/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:53 INFO - PROCESS | 1931 | RSS: Main: 330059776 20:19:53 INFO - PROCESS | 1931 | 20:19:56 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52477/tests/kraken/driver.html?testName=json-parse-financial) 20:19:57 INFO - PROCESS | 1931 | RSS: Main: 327761920 20:19:57 INFO - PROCESS | 1931 | 20:19:58 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:59 INFO - PROCESS | 1931 | RSS: Main: 304349184 20:19:59 INFO - PROCESS | 1931 | 20:20:01 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:20:02 INFO - PROCESS | 1931 | RSS: Main: 307920896 20:20:02 INFO - PROCESS | 1931 | 20:20:04 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:20:04 INFO - PROCESS | 1931 | RSS: Main: 309182464 20:20:04 INFO - PROCESS | 1931 | 20:20:07 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:20:08 INFO - PROCESS | 1931 | RSS: Main: 327839744 20:20:08 INFO - PROCESS | 1931 | 20:20:11 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:20:12 INFO - PROCESS | 1931 | RSS: Main: 321073152 20:20:12 INFO - PROCESS | 1931 | 20:20:13 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:52477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52477/tests/kraken/driver.html?testName=ai-astar) 20:20:14 INFO - PROCESS | 1931 | RSS: Main: 365727744 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | __start_tp_report 20:20:14 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 20:20:14 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 20:20:14 INFO - PROCESS | 1931 | |i|pagename|runs| 20:20:14 INFO - PROCESS | 1931 | |0;ai-astar;113;114;114;111;114;115;113;114;114;114 20:20:14 INFO - PROCESS | 1931 | |1;audio-beat-detection;143;111;108;143;110;110;111;108;129;109 20:20:14 INFO - PROCESS | 1931 | |2;audio-dft;183;183;183;185;185;183;181;183;182;182 20:20:14 INFO - PROCESS | 1931 | |3;audio-fft;79;58;58;86;63;57;59;59;74;58 20:20:14 INFO - PROCESS | 1931 | |4;audio-oscillator;84;71;87;70;69;69;82;68;67;83 20:20:14 INFO - PROCESS | 1931 | |5;imaging-gaussian-blur;88;85;88;85;87;84;89;87;74;114 20:20:14 INFO - PROCESS | 1931 | |6;imaging-darkroom;126;93;95;94;94;94;94;95;92;97 20:20:14 INFO - PROCESS | 1931 | |7;imaging-desaturate;85;87;88;84;90;85;85;85;87;85 20:20:14 INFO - PROCESS | 1931 | |8;json-parse-financial;55;53;54;54;55;54;56;55;55;54 20:20:14 INFO - PROCESS | 1931 | |9;json-stringify-tinderbox;66;75;76;74;76;72;93;106;108;83 20:20:14 INFO - PROCESS | 1931 | |10;stanford-crypto-aes;87;85;82;88;84;97;100;77;120;110 20:20:14 INFO - PROCESS | 1931 | |11;stanford-crypto-ccm;141;139;142;134;140;141;157;149;186;152 20:20:14 INFO - PROCESS | 1931 | |12;stanford-crypto-pbkdf2;175;174;171;173;170;174;178;176;178;176 20:20:14 INFO - PROCESS | 1931 | |13;stanford-crypto-sha256-iterative;67;67;67;67;66;68;67;68;78;86 20:20:14 INFO - PROCESS | 1931 | __end_tp_report 20:20:14 INFO - PROCESS | 1931 | __start_cc_report 20:20:14 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,2031 20:20:14 INFO - PROCESS | 1931 | __end_cc_report 20:20:14 INFO - PROCESS | 1931 | __startTimestamp1485318014230__endTimestamp 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | ------- Summary: start ------- 20:20:14 INFO - PROCESS | 1931 | Number of tests: 14 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 20:20:14 INFO - PROCESS | 1931 | Values: 113.0 114.0 114.0 111.0 114.0 115.0 113.0 114.0 114.0 114.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:111.00 stddev:14.44 (13.0%) stddev-sans-first:12.22 20:20:14 INFO - PROCESS | 1931 | Values: 143.0 111.0 108.0 143.0 110.0 110.0 111.0 108.0 129.0 109.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.25 (0.7%) stddev-sans-first:1.32 20:20:14 INFO - PROCESS | 1931 | Values: 183.0 183.0 183.0 185.0 185.0 183.0 181.0 183.0 182.0 182.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#3] audio-fft Cycles:10 Average:65.10 Median:61.00 stddev:10.57 (17.3%) stddev-sans-first:9.94 20:20:14 INFO - PROCESS | 1931 | Values: 79.0 58.0 58.0 86.0 63.0 57.0 59.0 59.0 74.0 58.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.50 stddev:7.92 (10.3%) stddev-sans-first:7.70 20:20:14 INFO - PROCESS | 1931 | Values: 84.0 71.0 87.0 70.0 69.0 69.0 82.0 68.0 67.0 83.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:87.00 stddev:10.05 (11.6%) stddev-sans-first:10.66 20:20:14 INFO - PROCESS | 1931 | Values: 88.0 85.0 88.0 85.0 87.0 84.0 89.0 87.0 74.0 114.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:94.00 stddev:10.13 (10.8%) stddev-sans-first:1.39 20:20:14 INFO - PROCESS | 1931 | Values: 126.0 93.0 95.0 94.0 94.0 94.0 94.0 95.0 92.0 97.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:1.85 (2.2%) stddev-sans-first:1.92 20:20:14 INFO - PROCESS | 1931 | Values: 85.0 87.0 88.0 84.0 90.0 85.0 85.0 85.0 87.0 85.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 20:20:14 INFO - PROCESS | 1931 | Values: 55.0 53.0 54.0 54.0 55.0 54.0 56.0 55.0 55.0 54.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#9] json-stringify-tinderbox Cycles:10 Average:82.90 Median:75.50 stddev:14.56 (19.3%) stddev-sans-first:14.10 20:20:14 INFO - PROCESS | 1931 | Values: 66.0 75.0 76.0 74.0 76.0 72.0 93.0 106.0 108.0 83.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:84.50 stddev:13.61 (16.1%) stddev-sans-first:14.26 20:20:14 INFO - PROCESS | 1931 | Values: 87.0 85.0 82.0 88.0 84.0 97.0 100.0 77.0 120.0 110.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:145.50 stddev:14.97 (10.3%) stddev-sans-first:15.66 20:20:14 INFO - PROCESS | 1931 | Values: 141.0 139.0 142.0 134.0 140.0 141.0 157.0 149.0 186.0 152.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.50 stddev:2.68 (1.5%) stddev-sans-first:2.83 20:20:14 INFO - PROCESS | 1931 | Values: 175.0 174.0 171.0 173.0 170.0 174.0 178.0 176.0 178.0 176.0 20:20:14 INFO - PROCESS | 1931 | 20:20:14 INFO - PROCESS | 1931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:67.50 stddev:6.57 (9.7%) stddev-sans-first:6.88 20:20:14 INFO - PROCESS | 1931 | Values: 67.0 67.0 67.0 67.0 66.0 68.0 67.0 68.0 78.0 86.0 20:20:14 INFO - PROCESS | 1931 | -------- Summary: end -------- 20:20:14 INFO - PROCESS | 1931 | 20:20:15 INFO - TEST-INFO | 1931: exit 0 20:20:15 INFO - TEST-OK | kraken | took 59344ms 20:20:15 INFO - SUITE-END | took 1177s 20:20:15 INFO - Completed test suite (00:19:37) 20:20:15 INFO - javascript benchmark 20:20:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2741.945161096778, 2815.7747380209585, 3130.4678204705197, 3239.4816829307315, 3371.6628337166303, 5567.276254086963, 5599.41206173352, 5753.993051216036, 5775.364709881915, 5786.0, 5641.041023026085, 5691.8292451226525, 5759.5968282220265, 5880.617759845607, 5886.4702176804185, 5117.513836185556, 5172.0, 5178.430372659023, 5190.532852043315, 5273.367195936474, 5135.537801597856, 5273.789048438058, 5291.867703307429, 5339.466053394668, 5393.0, 5114.872128196825, 5280.498352656491, 5281.498257665516, 5307.044731948267, 5331.653442526223, 5167.199084141964, 5170.922436163461, 5228.215767634847, 5228.2680424740565, 5237.973810130963, 5169.81905633301, 5207.9479205207845, 5219.034478621467, 5219.817306394258, 5230.8692282692855, 5626.634268772516, 5706.942930570683, 5722.54219662426, 5727.971360143172, 5732.8853422931725, 6154.907676384858, 6222.657753823538, 6246.750129994794, 6288.748450061992, 6299.590526615755, 6276.246850377984, 6277.497800175975, 6283.183186185813, 6295.716692748837, 6314.87370252597, 5727.3699893011735, 5748.885022299531, 5846.41535846412, 5903.468687818074, 5910.645361278294, 6207.503399728011, 6258.718357673915, 6278.215223097113, 6278.434940855345, 6324.620522768649, 6179.412955769195, 6199.473044791153, 6209.875802483925, 6222.12890195373, 6242.250929888442, 6281.937180628227, 6291.150694656254, 6307.4954003679595, 6313.810585682437, 6314.17915670969, 6100.115483254903, 6130.172426722335, 6143.262808463013, 6160.1375807387, 6171.0, 6201.193844800147, 6282.246130464374, 6293.3391993840905, 6293.496520278367, 6297.685115744194, 4968.677035992649, 5007.173816320266, 5023.899522009539, 5034.345535080416, 5047.242913562922, 3751.81240937952, 3940.9211815763524, 4376.540463251376, 4461.174682683714, 4484.977575112103, 5660.603757736919, 5718.0, 5727.2268243787385, 5755.59710820247, 5767.538596912321, 5780.335261444988, 6321.810345689637, 6333.936660633427, 6356.4279214870885, 6366.236051673829, 5725.770969161187, 5781.248437703071, 5795.94204057954, 5798.594098413155, 5866.823995280149, 5374.381946076173, 5451.918221226685, 5494.478024587658, 5499.230107784913, 5534.391216966131, 6235.968820155961, 6260.029695397221, 6267.937320626917, 6269.435750782452, 6380.680965951777, 6155.538334625011, 6263.592866463665, 6268.153799237227, 6279.152314437492, 6296.2759282681245, 6304.65324407162, 6322.272938612118, 6366.4588509977175, 6384.585001975042, 6385.138006369267, 6105.572609917263, 6111.7132884518705, 6150.954337762681, 6155.0, 6197.876042479035, 6257.7184026718, 6269.153664255267, 6269.874602508015, 6284.4344009039405, 6300.527460440394, 4666.696664716783, 5421.756020978986, 6116.755329786936, 6165.445109940127, 6206.317305096526, 5993.490553303018, 6036.607620504653, 6103.938960610337, 6108.236470441195, 6112.908306375319, 6019.097135429545, 6074.665893375906, 6081.6351018939, 6090.69546522681, 6115.449609535163, 5996.400359963969, 6036.6679832609625, 6199.225096862892, 6209.844753881009, 6253.7185826637, 5934.910976335272, 5966.582339236212, 5990.850228744316, 6010.669413182317, 6112.816615501542], "value": 5697.519154547853, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.961668258198, 458.17528448792166, 463.03457291547124, 468.28586405731255, 492.41402730750406, 29705.851470742644, 31678.208044798892, 37752.81123594385, 39103.60896391035, 39155.41266880999, 41354.7932260339, 41847.0, 41850.372244416285, 41852.37221441673, 41982.0, 8568.97172339317, 9180.311476639228, 9302.20931220847, 9324.906750932505, 9401.717948461523, 8411.453255538401, 8607.741767746978, 9368.484733339663, 11061.668149955514, 11360.48877800501, 11299.548018079267, 11335.263207891501, 11344.319340839576, 11350.035247004014, 11381.2033157679, 11184.496697648545, 11284.266522676, 11322.886771132265, 11363.090952723762, 11423.5430582777, 8294.3779216559, 8500.532470714108, 11098.44507774616, 11247.83128253077, 11371.431428428628, 39882.202355952715, 40258.59741402607, 40275.99310017244, 40286.0, 40335.7983210085, 3955.861544845917, 3971.5631280559114, 3985.183037477339, 4019.4774679291504, 4085.7957102144774, 29617.555736663966, 30417.847910760527, 30574.847125764452, 30828.845855770578, 30877.382452350826, 3126.937461250762, 3271.39701546243, 3274.5579346788354, 3280.9671903281137, 3312.254742682901, 476955.9999999965, 482696.0, 482890.0, 482945.0, 484593.0, 59540.70229648824, 59974.0, 59979.100313495335, 60122.69938650279, 60199.796004079675, 60347.69826150841, 62403.0, 62595.6870215646, 62644.0, 62711.372886270554, 15213.0, 15764.842351576337, 15779.0, 15788.0, 15789.447369342019, 11546.884531154748, 11554.191206615456, 11562.537498499965, 11567.42162891852, 11568.652940411801, 13570.05009649315, 13877.236751978537, 13919.304034798219, 15485.690286194213, 15768.684626307639, 6453.838654033593, 6474.643894585843, 7055.400290975324, 7098.36114749675, 7114.217436082027, 776.984460310802, 861.4615865084322, 880.9427387219811, 881.9717232714341, 914.9405288656216, 28510.42979140447, 29514.55728164079, 29573.112806615834, 30187.69812301849, 30619.38761224763, 1041.833306670929, 1057.1912486947492, 1057.281048886749, 1085.1969542538623, 1091.4379094766202, 12678.492860285669, 14813.407463701331, 15071.924640376728, 15154.772678409832, 15598.766018509732, 611242.0, 616149.0, 616730.0, 616826.0, 617426.0, 59967.70016149891, 59991.10013349716, 60005.69997149986, 60257.69871150704, 60373.0, 1395.6859706565942, 1418.560246323643, 1430.5565274764856, 1432.6060333408188, 1434.763264061439, 28075.0173743918, 28752.281192970342, 28880.956666066348, 29477.557836632037, 29773.80904763872, 47342.76328618335, 47347.0, 47446.76276618595, 47471.0, 47476.100955961374, 522816.0, 526108.738912606, 526665.0, 526947.0, 528574.7853953869, 25583.848726806966, 25867.353316167246, 25875.964961402085, 25883.482330352912, 25941.481170376108, 46253.53746462627, 46972.29541556811, 47079.82300442516, 47508.0, 47663.76168119276, 37965.430518542795, 38321.4251786229, 38386.61613383942, 39206.0, 39332.606673932896, 36431.99248082762, 37964.0, 38204.42693359546, 38660.0, 38860.41709374305, 33683.831580841936, 37363.0, 37816.43275350817, 37909.0, 38087.80956095202, 27770.0, 30897.073087807403, 31156.37687246288, 31186.376272474878, 31439.84280078585, 23430.64854027225, 23642.763572364056, 23831.614691268773, 23989.400264993514, 24000.51998960046], "value": 19551.330224321708, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.8275793135161, 395.8317714971137, 397.4376257595501, 406.3620116417225, 426.61391440746115, 14342.928285358572, 15842.0, 19153.61692766144, 19490.63565550412, 21614.459638509044, 20376.388708338738, 21699.240526581572, 22483.887580562114, 22648.0, 22816.31551053471, 4903.411590609123, 5779.335376431701, 5958.553108516857, 6026.126211699301, 6102.816915492543, 4249.532551419341, 5319.680819150844, 5669.489745922866, 5971.37300583439, 5976.0, 4436.401085853401, 6321.525885558579, 6600.603963762165, 6652.268250492466, 6732.663366831664, 6456.515761317873, 6615.702293396808, 6706.2287836898895, 6722.563033402813, 6729.125213722234, 5858.882822343529, 5859.1504231886565, 5861.0, 5862.853428664317, 5868.119782032687, 21926.684398935955, 25810.0, 26254.47491050168, 26424.60363094536, 26543.73456265432, 2128.5423633918626, 2730.959035614467, 2762.323230808445, 2766.8201566898088, 2775.1674497650824, 15844.28700708471, 15980.4406845761, 16094.195290235559, 16199.838001619952, 16879.0, 1816.6911625023777, 1843.5988648627006, 1853.379117995473, 1856.4152292027968, 1925.7689077310672, 88340.6748898767, 104691.42962855563, 110743.33884991732, 120710.79289207084, 120824.0, 10999.670009899715, 11076.169287303484, 11397.0, 11521.0, 11530.423478826026, 14033.368498417596, 14040.0, 14454.783178252335, 14520.927395363167, 14522.564323070324, 8434.072252052269, 8686.913130868737, 8688.39181257306, 8819.647214111492, 8827.779305517413, 8511.53186574732, 8546.871796923051, 8583.313334933191, 8740.21338079576, 8780.253678437404, 7087.782769252287, 7230.204142825059, 7237.240089790602, 7245.384142347854, 7257.564546127249, 1624.350259896051, 1892.687706528435, 1931.169597073244, 1937.2154277517627, 1938.195648805758, 819.8360327934317, 1017.867677201959, 1021.1320377678913, 1044.9425281609585, 1106.9612563560236, 17451.30194792194, 19433.805661943483, 22693.773062269494, 23343.53312933766, 23356.299311020695, 938.957746901391, 1004.0311099788739, 1074.3714926767927, 1124.2130508643982, 1126.099120703434, 11293.94353028246, 11950.70148673313, 12044.759104817855, 12143.635690929286, 12186.695332616579, 677593.0, 678631.0, 680430.0, 692845.0, 709417.0, 103286.35239176579, 114400.1279833633, 114712.0, 118908.0, 135366.0, 760.627292626609, 1007.8992100790009, 1037.9792404151874, 1040.2926010312908, 1042.3485321673954, 20848.58302833965, 21512.0, 21520.89239553792, 21562.568748624624, 21700.34898953034, 55685.0, 55686.72156639191, 56431.15353269786, 56840.71579642075, 57745.422545774, 79554.0, 80714.38571228425, 81340.18659813327, 81993.59003204945, 86423.2715345677, 5559.777608895761, 5650.491455769001, 5663.830085097454, 8061.919380806117, 8127.431079824356, 13432.529861454803, 13452.596422107352, 13539.729205416033, 13922.955778316464, 13998.880089593013, 10360.740981475223, 10531.420771857314, 11475.368854713071, 11783.88216117862, 11892.286462812259, 11180.608678696206, 11208.551657933918, 11212.822653621579, 11389.715257118638, 12040.531691003498, 8148.0, 11553.422328883691, 11836.408179591159, 11845.289282643069, 11904.642860714192, 8041.195880411912, 8275.0, 8316.0, 8317.376196785386, 8463.069062403254, 11548.0, 11622.825657614974, 11963.700907477383, 11985.580504682293, 12030.09774266916], "value": 10033.938960020616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.2276693352526, 1460.277162804412, 1472.734907716611, 1484.4730120807105, 1488.3451281436164, 7941.245581669747, 8342.95828520858, 8347.83304333913, 8363.20549547792, 8367.832643347137, 7476.401887848972, 7679.347255483291, 7689.307962283393, 7931.8413631727335, 8217.506949583028, 2258.898349574265, 2312.456572705413, 2314.4445333120098, 2315.8610483370967, 2315.918942837001, 2299.4251437140715, 2323.465602911331, 2330.8368414211013, 2342.2973108067595, 2342.6603142544323, 2268.9886550567226, 2283.9200627978025, 2291.86248825071, 2317.9884100579475, 2323.2913961241898, 2268.7731226877345, 2271.5229801741652, 2296.3455415206586, 2306.273523839985, 2308.3421224950976, 1973.8223559879536, 2250.054976909702, 2320.4082958845556, 2328.406256404623, 2336.030547322859, 8296.377771667148, 8365.24712775847, 8378.03652579955, 8384.8742268866, 8432.241098301121, 5037.143685573425, 5189.974050129763, 5191.506806853343, 5195.220716892459, 5195.947600697703, 3257.1368587324378, 3347.681970212826, 3548.7515873888838, 3550.7869527828157, 3556.05764472415, 1022.8977102289786, 1202.9338386388745, 1234.6913271682079, 1234.9012079033655, 1256.2525297448094, 10646.414447205401, 10741.462926853626, 10742.3017503862, 10746.140308775279, 10759.408232547206, 4377.146456441027, 4612.815487380467, 4638.930416043762, 4692.436907571113, 4694.413198350207, 9273.397229180082, 9342.299327550461, 9372.1565059145, 9374.062593740708, 9395.060493950687, 5207.427183009866, 5214.0875346814155, 5222.242774797709, 5224.8171314004585, 5225.712585807741, 4207.600277973587, 4225.556316586714, 4689.226277664216, 4708.741019243906, 4782.641301902371, 3742.401215805458, 3758.0, 3841.8463261469788, 3844.6539811417106, 3891.571927088018, 1251.8622951475331, 1272.4719241514667, 1273.611548477723, 1285.7235694325766, 1287.0540152987546, 774.4230548241484, 845.9848182181407, 907.396581273459, 911.2709832134266, 940.8024314893812, 5479.780808767605, 5481.150421684645, 5633.521150702154, 5790.536757059425, 5802.506786923159, 965.6475386483883, 990.9851352229722, 991.8611394404645, 1006.2654262388497, 1040.4433628008978, 3669.284489524517, 3684.3184010958057, 3696.1334526064165, 3794.487744154559, 3795.867144649924, 9657.565409556446, 9936.453495057696, 9966.302358834811, 9970.252231082697, 9974.950125249326, 9836.557354919047, 9908.900910990798, 9930.553125109387, 9933.602655893828, 9937.602495900228, 7632.389408847279, 7685.42359323053, 7759.767206983686, 7771.961140194263, 7772.417068719868, 4740.9051818962735, 4799.688020278671, 4932.556069953722, 4934.111859865258, 5072.061668591323, 8875.600597972978, 9117.08829117083, 9163.175314221751, 9215.76960575991, 9235.399699019543, 9139.177474027369, 9330.020347863376, 9414.670486533212, 9455.479948602893, 9465.574049167943, 6655.201375834931, 6682.599044057372, 6689.431398331197, 6802.455803535804, 6803.25164231944, 7742.845143097219, 7820.491668041559, 7835.5690437026515, 7841.137474877873, 7851.960740196491, 6845.691943862637, 7048.330408611174, 7073.858522829618, 7098.396636285974, 7161.713531458683, 6863.933546630742, 6908.44732421395, 6923.8961415579815, 7009.614471204132, 7032.980217868483, 6324.083007963727, 6336.20797400325, 6385.904211436739, 6414.807555773335, 6419.037144428186, 4830.565249127595, 4873.4639189689815, 4914.606831453403, 4923.926141107958, 5020.598352131894, 4616.653750968623, 4911.165101932608, 4978.253262010582, 5019.598432125348, 5035.924461133012], "value": 4386.639047374765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.3555135261916, 354.0723304941055, 364.28418158318897, 372.7130109815444, 374.8051013472994, 4652.837150699726, 5372.0, 5384.876771472546, 5404.48657377549, 5414.756335964886, 4799.496052914437, 4987.650864439482, 5072.442031376546, 5115.846524604259, 5207.7916883324715, 3415.419378705626, 4061.6547593454593, 4117.794110294488, 4143.606357396043, 4155.667546596265, 3484.756067075306, 3994.8801535953967, 4102.620480121523, 4145.212409642173, 4147.460830092084, 3642.3079614873222, 3712.5544934607883, 3918.294706952747, 4101.79491025449, 4149.792510374485, 3746.138388170709, 3805.238952209569, 4061.4923134608175, 4105.815238314268, 4110.7328023678365, 3594.813711475207, 3602.676787854559, 3606.6934310583633, 3613.6386361363916, 3614.1868079681863, 4826.32431459596, 5098.362704661918, 5118.513741194581, 5125.871853203663, 5151.0, 3831.8084095795098, 4542.160425027836, 4555.954440455619, 4592.862214133581, 4597.42532183477, 5585.2459917910965, 5606.785689308941, 5613.46672066153, 5619.8595035124445, 5639.379668236491, 3321.7674762766615, 3604.7203242848936, 3810.8856734298015, 3831.2337532493334, 3831.291211125923, 5322.467753224647, 5461.3785383016375, 5783.397471137962, 5820.272465941757, 5825.135956493924, 3831.233753249361, 3839.9040023999623, 3840.5967373425387, 3848.0956975110826, 3863.690904727615, 3884.6309600587897, 3889.7082718796205, 3890.455336252927, 3899.941500877489, 3906.3945088511327, 4337.443296496842, 4531.410916580823, 4556.453225612948, 4598.793054312564, 4615.3999980003055, 4923.359963204832, 5403.8108666196495, 5575.414581468968, 5577.123898890313, 5674.517665998354, 1204.6325870609548, 1252.136026141959, 1257.251935098615, 1259.6535952613106, 1274.8278982337265, 742.1465314887814, 787.696736756353, 810.8621534339177, 824.9505029698238, 858.6393714639867, 4321.558319549445, 4794.202174184681, 4865.3701010161285, 4880.0, 4880.55972013993, 5135.845924622267, 5139.717315547681, 5357.785688572491, 5399.0, 5459.645123066988, 4369.71596846204, 4507.639388848885, 4800.831970881002, 4846.39420072491, 4877.317175595419, 2228.286948176568, 2544.849602086234, 2824.56219286011, 2828.533292006837, 2841.829490230593, 4543.159515489645, 5483.8080667176455, 5544.417836127229, 5568.303962004749, 5607.663540187602, 4695.624350051988, 4894.070126675921, 5424.484673955968, 5541.445855414427, 5614.6805500707305, 5030.37120359955, 5367.819079802437, 5417.020638648806, 5581.441855814386, 5620.409856965041, 4762.78567464458, 5328.682023319869, 5371.677699337896, 5411.458854114557, 5435.809746658848, 5031.270465782368, 5678.914816277842, 5704.743286552032, 5709.314882214161, 5746.511546518593, 5250.343707036621, 5366.490183432567, 5933.884710527008, 6001.109650460091, 6027.638341699512, 3928.9981054830837, 4012.53855806586, 4186.455760751083, 4199.2441360555395, 4207.368894665825, 4662.927526668817, 5193.75349916025, 5519.1234980105355, 5781.046127388934, 5794.333651630117, 5058.3929928408825, 5073.34046573943, 5292.867678307919, 5561.888762224814, 5662.2639056922335, 4893.632977526629, 5560.277163968658, 5597.788873395068, 5626.5780066496, 5648.689322087324, 4693.929591056205, 5067.46791586878, 5080.949190508048, 5189.532942035235, 5486.588505861996, 5088.0, 5224.608154388512, 5416.75624596902, 5455.381416919821, 5512.972435137799, 5067.239914012927, 5485.698286594116, 5515.834524964257, 5536.871667507845, 5544.63959842609], "value": 4029.5141640800884, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.2150846915944, 703.2650879830579, 767.973120940767, 773.6363908962785, 837.9748607541774, 14842.77735833962, 15761.527154185364, 15781.526554203378, 15792.131432771193, 15799.052056876595, 14063.296835158228, 14205.857941420583, 14351.28243587819, 14567.417303307855, 14599.854001459982, 681.9727210911558, 702.0382076555101, 703.1737708192878, 852.7825404521869, 862.3704695572236, 873.6199753107387, 876.8553188723885, 878.9560521973875, 879.0725784297564, 880.7049638371153, 927.0405130689737, 945.5697657565792, 948.340903072365, 948.5921053946801, 949.8242825077348, 782.6517199846071, 936.9390989585723, 938.9342746007782, 942.105000249762, 942.1567696911295, 529.1110933631497, 546.1180193986722, 672.5426709837309, 696.853660731247, 697.2191145916555, 14747.262636868114, 15315.923420382938, 15320.923395383063, 15347.232638368037, 15356.0, 13697.794533082011, 13698.589042328746, 13705.177689338572, 13763.38064787087, 13785.310734463237, 10912.0, 12421.254724716546, 12595.181313214704, 12657.683557911034, 12687.302198379086, 3951.5060617422823, 4399.846005389828, 4412.624926881219, 4574.290984897346, 4635.2120139576355, 112770.0, 114593.0, 114888.0, 116850.41574792156, 118131.81868181295, 10704.30422022566, 10835.295705779099, 10870.565177392815, 11212.607558735404, 11388.772224555629, 17674.646507070043, 21202.78797212039, 21304.36086917395, 21436.24973125933, 21460.78539214619, 7663.578503182379, 7678.616069196518, 7717.0, 7730.226977302337, 7773.989381380385, 3527.664871837171, 4258.765767882796, 4311.2239796836875, 4384.079343337935, 4436.0906014267, 3359.714424273915, 3426.5716785401823, 3436.742244331685, 3452.637473065292, 3458.342914846171, 655.0469067506766, 658.3712554510431, 671.6977360187935, 705.5801797930224, 707.6850801393331, 503.7833731495492, 607.1590846677384, 631.57999930046, 658.8601719026111, 662.5494663628779, 9074.682386116454, 10825.26795712698, 11135.888641113484, 11409.0, 11438.026113210459, 478.3327258474409, 565.4571611253243, 595.8391234366696, 638.0142679560091, 684.8356394465293, 4586.334981427741, 5057.241413787888, 5058.822941197041, 5062.240663900445, 5069.138246498031, 73852.0, 95544.0, 97123.51438242904, 97137.0, 99931.00068999363, 85318.14681853226, 87914.0, 89146.10853891508, 89394.55302723445, 90963.0, 74344.0, 77510.6124469374, 81163.0, 82702.0, 84235.0, 8626.568671566522, 11087.611933582286, 11149.498272577592, 11201.719957000814, 11354.94322528415, 53023.46976530185, 53766.0, 54264.0, 55056.0730374435, 55797.978181963816, 57624.423755761905, 70617.0, 71389.64305178648, 73290.0, 75286.62356688401, 13415.396307166005, 13796.586102416944, 13804.654883627989, 13905.37425815861, 14404.99165058436, 13309.800352994907, 13384.93307533456, 13394.93302533481, 13404.416605158473, 13427.798583021458, 11914.67815675437, 13938.721225575635, 13979.650508737363, 14368.353424096149, 14564.0, 13380.0, 13541.796873046715, 13659.04386692922, 13932.651683707989, 14047.227402492961, 12860.614181574567, 13022.088453808521, 13373.598792036255, 13718.93140534291, 13783.310834458036, 11351.829722554334, 11363.943180284046, 11627.583327534605, 11734.882651173379, 12009.159358845147, 8941.865872011795, 10983.231173817756, 10987.340759554452, 11177.944110279397, 11223.66329010131], "value": 7547.031364346923, "unit": "score"}], "name": "dromaeo_css", "value": 7282.107472272884, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 111.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 108.0, 143.0, 110.0, 110.0, 111.0, 108.0, 129.0, 109.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 185.0, 185.0, 183.0, 181.0, 183.0, 182.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 86.0, 63.0, 57.0, 59.0, 59.0, 74.0, 58.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 87.0, 70.0, 69.0, 69.0, 82.0, 68.0, 67.0, 83.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 84.0, 89.0, 87.0, 74.0, 114.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 92.0, 97.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 88.0, 84.0, 90.0, 85.0, 85.0, 85.0, 87.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 55.0, 54.0, 56.0, 55.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 76.0, 74.0, 76.0, 72.0, 93.0, 106.0, 108.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 82.0, 88.0, 84.0, 97.0, 100.0, 77.0, 120.0, 110.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 142.0, 134.0, 140.0, 141.0, 157.0, 149.0, 186.0, 152.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 171.0, 173.0, 170.0, 174.0, 178.0, 176.0, 178.0, 176.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 68.0, 78.0, 86.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1449.6, "alertThreshold": 2.0}]} 20:20:15 INFO - Return code: 0 20:20:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:20:15 ERROR - # TBPL SUCCESS # 20:20:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:20:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:20:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:20:15 INFO - 2017-01-24 20:20:15.504 screenresolution[1935:18171] starting screenresolution argv=screenresolution get 20:20:15 INFO - 2017-01-24 20:20:15.506 screenresolution[1935:18171] Display 0: 1600x1200x32@60 20:20:15 INFO - 2017-01-24 20:20:15.512 screenresolution[1936:18174] starting screenresolution argv=screenresolution list 20:20:15 INFO - Available Modes on Display 0 20:20:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:20:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:20:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:20:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:20:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:20:15 INFO - Intel Iris: 20:20:15 INFO - Chipset Model: Intel Iris 20:20:15 INFO - Type: GPU 20:20:15 INFO - Bus: Built-In 20:20:15 INFO - VRAM (Dynamic, Max): 1536 MB 20:20:15 INFO - Vendor: Intel (0x8086) 20:20:15 INFO - Device ID: 0x0a2e 20:20:15 INFO - Revision ID: 0x0009 20:20:15 INFO - Displays: 20:20:15 INFO - Display: 20:20:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:20:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:20:15 INFO - Display Serial Number: 1600x1200 60 20:20:15 INFO - Main Display: Yes 20:20:15 INFO - Mirror: Off 20:20:15 INFO - Online: Yes 20:20:15 INFO - Rotation: Supported 20:20:15 INFO - Return code: 0 20:20:15 INFO - Running post-action listener: _resource_record_post_action 20:20:15 INFO - [mozharness: 2017-01-25 04:20:15.755196Z] Finished run-tests step (success) 20:20:15 INFO - Running post-run listener: _resource_record_post_run 20:20:15 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 720896; Write bytes: 550364160; Read time: 11; Write time: 1654 20:20:15 INFO - TinderboxPrint: CPU usage
53.8% 20:20:15 INFO - TinderboxPrint: I/O read bytes / time
720,896 / 11 20:20:15 INFO - TinderboxPrint: I/O write bytes / time
550,364,160 / 1,654 20:20:15 INFO - TinderboxPrint: CPU idle
2,219.9 (46.2%) 20:20:15 INFO - TinderboxPrint: CPU system
963.5 (20.1%) 20:20:15 INFO - TinderboxPrint: CPU user
1,618.2 (33.7%) 20:20:15 INFO - TinderboxPrint: Swap in / out
252,022,784 / 0 20:20:15 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247048704; Write bytes: 242526208; Read time: 18122; Write time: 516 20:20:15 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 679936; Write bytes: 294226944; Read time: 10; Write time: 1097 20:20:16 INFO - Running post-run listener: _upload_blobber_files 20:20:16 INFO - Blob upload gear active. 20:20:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:20:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:20:16 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'] 20:20:16 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 20:20:16 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:20:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:20:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:17 INFO - (blobuploader) - INFO - Done attempting. 20:20:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:20:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:20:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:18 INFO - (blobuploader) - INFO - Done attempting. 20:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:19 INFO - (blobuploader) - INFO - Done attempting. 20:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:20:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:21 INFO - (blobuploader) - INFO - Done attempting. 20:20:21 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:21 INFO - Return code: 0 20:20:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:20:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4801481c9955c2746ec25d4772b606669f153e3ecdfbc89ab6eeb296b8e7fb565b7527de63bf6d21cae95c3c6cea78931d14adee726a63dd6bcaded62472859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cd6bc55a2a952a392f48d4ac2b46fffd87eeea6991535404bcfa5959d86494d698b09e47f630e451bbd7745f99fba8f9e90ea5be7ffeabe6f02bffefcae924c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ef82c55e656e55f0a4a901c88cef1177b20c9a2ed410e64e5294ff2aa3416d005a11c739618c1055383991615a6e5c14cd92edd87a9c43d77ef6269162df732", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bf45e7607e5fa88e78764d091787a9e974353feda89b746456b112a952e3703fd2ff458f0dd67e617cc6238b277ab5137596686fbd189d20942c66f19566fa"} 20:20:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:20:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:20:21 INFO - Contents: 20:20:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4801481c9955c2746ec25d4772b606669f153e3ecdfbc89ab6eeb296b8e7fb565b7527de63bf6d21cae95c3c6cea78931d14adee726a63dd6bcaded62472859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cd6bc55a2a952a392f48d4ac2b46fffd87eeea6991535404bcfa5959d86494d698b09e47f630e451bbd7745f99fba8f9e90ea5be7ffeabe6f02bffefcae924c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ef82c55e656e55f0a4a901c88cef1177b20c9a2ed410e64e5294ff2aa3416d005a11c739618c1055383991615a6e5c14cd92edd87a9c43d77ef6269162df732", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bf45e7607e5fa88e78764d091787a9e974353feda89b746456b112a952e3703fd2ff458f0dd67e617cc6238b277ab5137596686fbd189d20942c66f19566fa"} 20:20:21 INFO - Running post-run listener: copy_logs_to_upload_dir 20:20:21 INFO - Copying logs to upload dir... 20:20:21 INFO - mkdir: /builds/slave/test/build/upload/logs 20:20:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.311291 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-24 20:20:21.981637) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 20:20:21.985028) ========= 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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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/c4801481c9955c2746ec25d4772b606669f153e3ecdfbc89ab6eeb296b8e7fb565b7527de63bf6d21cae95c3c6cea78931d14adee726a63dd6bcaded62472859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cd6bc55a2a952a392f48d4ac2b46fffd87eeea6991535404bcfa5959d86494d698b09e47f630e451bbd7745f99fba8f9e90ea5be7ffeabe6f02bffefcae924c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ef82c55e656e55f0a4a901c88cef1177b20c9a2ed410e64e5294ff2aa3416d005a11c739618c1055383991615a6e5c14cd92edd87a9c43d77ef6269162df732", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bf45e7607e5fa88e78764d091787a9e974353feda89b746456b112a952e3703fd2ff458f0dd67e617cc6238b277ab5137596686fbd189d20942c66f19566fa"} build_url:https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/RQ_N4Wu7SZufK3BJCMBwqg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4801481c9955c2746ec25d4772b606669f153e3ecdfbc89ab6eeb296b8e7fb565b7527de63bf6d21cae95c3c6cea78931d14adee726a63dd6bcaded62472859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cd6bc55a2a952a392f48d4ac2b46fffd87eeea6991535404bcfa5959d86494d698b09e47f630e451bbd7745f99fba8f9e90ea5be7ffeabe6f02bffefcae924c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ef82c55e656e55f0a4a901c88cef1177b20c9a2ed410e64e5294ff2aa3416d005a11c739618c1055383991615a6e5c14cd92edd87a9c43d77ef6269162df732", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bf45e7607e5fa88e78764d091787a9e974353feda89b746456b112a952e3703fd2ff458f0dd67e617cc6238b277ab5137596686fbd189d20942c66f19566fa"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 20:20:22.023229) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:20:22.023916) ========= 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.YiNeJTfvMt/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.dmwMD5EoPz/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005258 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 20:20:22.076023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 20:20:22.076790) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 20:20:22.077420) ========= ========= Total master_lag: 0.19 =========