builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0288 starttime: 1487782421.31 results: success (0) buildid: 20170222065927 builduid: 973c364a283a49dc93aec4bbcd321044 revision: 8e4f44727c5bb84cd613de9ec81b8c65ca8c51c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.311948) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.312385) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.312673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.338680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.339029) ========= 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.mAQKJJzBai/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.k3plXjwhDF/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-02-22 08:53:41-- 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% 19.8M=0.001s 2017-02-22 08:53:41 (19.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.382353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.743040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.743386) ========= 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.mAQKJJzBai/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.k3plXjwhDF/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.024620 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.792219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:41.792571) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e4f44727c5bb84cd613de9ec81b8c65ca8c51c3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e4f44727c5bb84cd613de9ec81b8c65ca8c51c3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mAQKJJzBai/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.k3plXjwhDF/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-02-22 08:53:41,879 truncating revision to first 12 chars 2017-02-22 08:53:41,879 Setting DEBUG logging. 2017-02-22 08:53:41,879 attempt 1/10 2017-02-22 08:53:41,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e4f44727c5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 08:53:42,401 unpacking tar archive at: mozilla-aurora-8e4f44727c5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.798394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:42.612070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:42.612396) ========= script_repo_revision: 8e4f44727c5bb84cd613de9ec81b8c65ca8c51c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:42.612783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:42.613043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 08:53:42.630655) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-22 08:53:42.631035) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mAQKJJzBai/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.k3plXjwhDF/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:53:42 INFO - MultiFileLogger online at 20170222 08:53:42 in /builds/slave/test 08:53:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:53:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:42 INFO - {'append_to_log': False, 08:53:42 INFO - 'base_work_dir': '/builds/slave/test', 08:53:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:53:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:42 INFO - 'branch': 'Mozilla-Aurora', 08:53:42 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:42 INFO - 'config_files': ('talos/mac_config.py',), 08:53:42 INFO - 'default_actions': ('clobber', 08:53:42 INFO - 'read-buildbot-config', 08:53:42 INFO - 'download-and-extract', 08:53:42 INFO - 'populate-webroot', 08:53:42 INFO - 'create-virtualenv', 08:53:42 INFO - 'install', 08:53:42 INFO - 'run-tests'), 08:53:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:42 INFO - 'download_minidump_stackwalk': True, 08:53:42 INFO - 'download_symbols': 'ondemand', 08:53:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:42 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:42 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:42 INFO - 'installer_path': 'installer.exe', 08:53:42 INFO - 'log_level': 'info', 08:53:42 INFO - 'log_name': 'talos', 08:53:42 INFO - 'log_to_console': True, 08:53:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:53:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:53:42 INFO - 'opt_config_files': (), 08:53:42 INFO - 'pip_index': False, 08:53:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:42 INFO - 'cmd': ('bash', 08:53:42 INFO - '-c', 08:53:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:42 INFO - 'enabled': True, 08:53:42 INFO - 'halt_on_failure': False, 08:53:42 INFO - 'name': 'check_screen_resolution'},), 08:53:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:42 INFO - 'cmd': ('bash', 08:53:42 INFO - '-c', 08:53:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:42 INFO - 'enabled': True, 08:53:42 INFO - 'halt_on_failure': False, 08:53:42 INFO - 'name': 'check_screen_resolution'},), 08:53:42 INFO - 'run_cmd_checks_enabled': True, 08:53:42 INFO - 'sps_profile': False, 08:53:42 INFO - 'sps_profile_interval': 0, 08:53:42 INFO - 'suite': 'dromaeojs', 08:53:42 INFO - 'system_bits': '32', 08:53:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:42 INFO - 'title': 't-yosemite-r7-0288', 08:53:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:42 INFO - 'use_talos_json': True, 08:53:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:42 INFO - 'work_dir': 'build'} 08:53:42 INFO - [mozharness: 2017-02-22 16:53:42.820787Z] Running clobber step. 08:53:42 INFO - Running pre-action listener: _resource_record_pre_action 08:53:42 INFO - Running main action method: clobber 08:53:42 INFO - rmtree: /builds/slave/test/build 08:53:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:45 INFO - Running post-action listener: _resource_record_post_action 08:53:45 INFO - [mozharness: 2017-02-22 16:53:45.158510Z] Finished clobber step (success) 08:53:45 INFO - [mozharness: 2017-02-22 16:53:45.158648Z] Running read-buildbot-config step. 08:53:45 INFO - Running pre-action listener: _resource_record_pre_action 08:53:45 INFO - Running main action method: read_buildbot_config 08:53:45 INFO - Using buildbot properties: 08:53:45 INFO - { 08:53:45 INFO - "project": "", 08:53:45 INFO - "product": "firefox", 08:53:45 INFO - "script_repo_revision": "production", 08:53:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:53:45 INFO - "repository": "", 08:53:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:53:45 INFO - "buildid": "20170222065927", 08:53:45 INFO - "pgo_build": "False", 08:53:45 INFO - "basedir": "/builds/slave/test", 08:53:45 INFO - "buildnumber": 36, 08:53:45 INFO - "slavename": "t-yosemite-r7-0288", 08:53:45 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:53:45 INFO - "platform": "yosemite_r7", 08:53:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:53:45 INFO - "branch": "mozilla-aurora", 08:53:45 INFO - "repo_path": "releases/mozilla-aurora", 08:53:45 INFO - "revision": "8e4f44727c5bb84cd613de9ec81b8c65ca8c51c3", 08:53:45 INFO - "stage_platform": "macosx64", 08:53:45 INFO - "builduid": "973c364a283a49dc93aec4bbcd321044", 08:53:45 INFO - "slavebuilddir": "test" 08:53:45 INFO - } 08:53:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:53:45 INFO - Running post-action listener: _resource_record_post_action 08:53:45 INFO - [mozharness: 2017-02-22 16:53:45.161906Z] Finished read-buildbot-config step (success) 08:53:45 INFO - [mozharness: 2017-02-22 16:53:45.162046Z] Running download-and-extract step. 08:53:45 INFO - Running pre-action listener: _resource_record_pre_action 08:53:45 INFO - Running main action method: download_and_extract 08:53:45 INFO - mkdir: /builds/slave/test/build/tests 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - trying https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:53:45 INFO - Downloading https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:53:46 INFO - Downloaded 1199 bytes. 08:53:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:53:46 INFO - Using the following test package requirements: 08:53:46 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:53:46 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:53:46 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:53:46 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'jsshell-mac.zip'], 08:53:46 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:53:46 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:53:46 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:53:46 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:53:46 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:53:46 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:53:46 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:53:46 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:53:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:53:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:53:46 INFO - Fetch https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:53:47 INFO - Expected file size: 16357546 08:53:47 INFO - Obtained file size: 16357546 08:53:53 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:53:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:53:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:53:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:53:54 INFO - Expected file size: 16357546 08:53:54 INFO - Obtained file size: 16357546 08:54:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:54:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:54:00 INFO - Fetch https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:54:01 INFO - Expected file size: 14403485 08:54:01 INFO - Obtained file size: 14403485 08:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:02 INFO - trying https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:54:02 INFO - Downloading https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:54:04 INFO - Downloaded 73930054 bytes. 08:54:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:54:04 INFO - mkdir: /builds/slave/test/properties 08:54:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:04 INFO - Contents: 08:54:04 INFO - build_url:https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:54:05 INFO - Running post-action listener: _resource_record_post_action 08:54:05 INFO - Running post-action listener: set_extra_try_arguments 08:54:05 INFO - [mozharness: 2017-02-22 16:54:05.079655Z] Finished download-and-extract step (success) 08:54:05 INFO - [mozharness: 2017-02-22 16:54:05.079807Z] Running populate-webroot step. 08:54:05 INFO - Running pre-action listener: _resource_record_pre_action 08:54:05 INFO - Running main action method: populate_webroot 08:54:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:05 INFO - '--tppagecycles', 08:54:05 INFO - '7'], 08:54:05 INFO - 'tests': ['tsvgm']}}, 08:54:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:54:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:54:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:54:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:54:05 INFO - 'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:54:05 INFO - 'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['damp', 'tps']}, 08:54:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:54:05 INFO - 'tests': ['damp', 'tps']}, 08:54:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['dromaeo_dom']}, 08:54:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['basic_compositor_video']}, 08:54:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:54:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['a11yr', 08:54:05 INFO - 'ts_paint', 08:54:05 INFO - 'tpaint', 08:54:05 INFO - 'sessionrestore', 08:54:05 INFO - 'sessionrestore_no_auto_restore', 08:54:05 INFO - 'tabpaint']}, 08:54:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:54:05 INFO - 'ts_paint', 08:54:05 INFO - 'tpaint', 08:54:05 INFO - 'sessionrestore', 08:54:05 INFO - 'sessionrestore_no_auto_restore', 08:54:05 INFO - 'tabpaint']}, 08:54:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:54:05 INFO - 'ts_paint', 08:54:05 INFO - 'tpaint', 08:54:05 INFO - 'sessionrestore', 08:54:05 INFO - 'sessionrestore_no_auto_restore', 08:54:05 INFO - 'tabpaint']}, 08:54:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:54:05 INFO - 'ts_paint', 08:54:05 INFO - 'tpaint', 08:54:05 INFO - 'sessionrestore', 08:54:05 INFO - 'sessionrestore_no_auto_restore', 08:54:05 INFO - 'tabpaint']}, 08:54:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['a11yr', 08:54:05 INFO - 'ts_paint', 08:54:05 INFO - 'tpaint', 08:54:05 INFO - 'sessionrestore', 08:54:05 INFO - 'sessionrestore_no_auto_restore', 08:54:05 INFO - 'tabpaint']}, 08:54:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['a11yr', 08:54:05 INFO - 'ts_paint', 08:54:05 INFO - 'tpaint', 08:54:05 INFO - 'sessionrestore', 08:54:05 INFO - 'sessionrestore_no_auto_restore', 08:54:05 INFO - 'tabpaint']}, 08:54:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['tsvgx', 08:54:05 INFO - 'tsvgr_opacity', 08:54:05 INFO - 'tart', 08:54:05 INFO - 'tscrollx', 08:54:05 INFO - 'cart', 08:54:05 INFO - 'tsvg_static']}, 08:54:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:54:05 INFO - 'tsvgr_opacity', 08:54:05 INFO - 'tart', 08:54:05 INFO - 'tscrollx', 08:54:05 INFO - 'cart', 08:54:05 INFO - 'tsvg_static']}, 08:54:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:54:05 INFO - 'talos_options': ['--disable-e10s'], 08:54:05 INFO - 'tests': ['tp5o']}, 08:54:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:54:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:54:05 INFO - 'talos_options': ['--disable-e10s', 08:54:05 INFO - '--xperf_path', 08:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:05 INFO - 'tests': ['tp5n']}, 08:54:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:54:05 INFO - 'talos_options': ['--xperf_path', 08:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:05 INFO - 'tests': ['tp5n']}}, 08:54:05 INFO - 'talos.zip': {'path': '', 08:54:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:05 INFO - Running post-action listener: _resource_record_post_action 08:54:05 INFO - [mozharness: 2017-02-22 16:54:05.098303Z] Finished populate-webroot step (success) 08:54:05 INFO - [mozharness: 2017-02-22 16:54:05.098423Z] Running create-virtualenv step. 08:54:05 INFO - Running pre-action listener: _resource_record_pre_action 08:54:05 INFO - Running main action method: create_virtualenv 08:54:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:54:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:05 INFO - Using real prefix '/tools/python27' 08:54:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:08 INFO - Installing pip.................done. 08:54:08 INFO - Return code: 0 08:54:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:54:09 INFO - Reading from file tmpfile_stdout 08:54:09 INFO - Output received: 08:54:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:54:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:09 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:09 INFO - 'HOME': '/Users/cltbld', 08:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:09 INFO - 'LOGNAME': 'cltbld', 08:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:09 INFO - 'MOZ_NO_REMOTE': '1', 08:54:09 INFO - 'NO_EM_RESTART': '1', 08:54:09 INFO - 'PAGER': '/bin/cat', 08:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:09 INFO - 'PWD': '/builds/slave/test', 08:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:09 INFO - 'SHELL': '/bin/bash', 08:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:09 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:09 INFO - 'USER': 'cltbld', 08:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:09 INFO - 'XPC_FLAGS': '0x0', 08:54:09 INFO - 'XPC_SERVICE_NAME': '0', 08:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:54:09 INFO - Cleaning up... 08:54:09 INFO - Return code: 0 08:54:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:09 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:09 INFO - 'HOME': '/Users/cltbld', 08:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:09 INFO - 'LOGNAME': 'cltbld', 08:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:09 INFO - 'MOZ_NO_REMOTE': '1', 08:54:09 INFO - 'NO_EM_RESTART': '1', 08:54:09 INFO - 'PAGER': '/bin/cat', 08:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:09 INFO - 'PWD': '/builds/slave/test', 08:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:09 INFO - 'SHELL': '/bin/bash', 08:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:09 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:09 INFO - 'USER': 'cltbld', 08:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:09 INFO - 'XPC_FLAGS': '0x0', 08:54:09 INFO - 'XPC_SERVICE_NAME': '0', 08:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:09 INFO - Downloading/unpacking psutil>=3.1.1 08:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:13 INFO - Installing collected packages: psutil 08:54:13 INFO - Running setup.py install for psutil 08:54:13 INFO - building 'psutil._psutil_osx' extension 08:54:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:54:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:54:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:54:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:54:13 INFO - building 'psutil._psutil_posix' extension 08:54:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:54:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:54:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:54:14 INFO - ^ 08:54:14 INFO - 1 warning generated. 08:54:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:54:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:14 INFO - Successfully installed psutil 08:54:14 INFO - Cleaning up... 08:54:14 INFO - Return code: 0 08:54:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:54: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 mozsystemmonitor==0.3 08:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:14 INFO - 'HOME': '/Users/cltbld', 08:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:14 INFO - 'LOGNAME': 'cltbld', 08:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:14 INFO - 'MOZ_NO_REMOTE': '1', 08:54:14 INFO - 'NO_EM_RESTART': '1', 08:54:14 INFO - 'PAGER': '/bin/cat', 08:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:14 INFO - 'PWD': '/builds/slave/test', 08:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:14 INFO - 'SHELL': '/bin/bash', 08:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:14 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:14 INFO - 'USER': 'cltbld', 08:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:14 INFO - 'XPC_FLAGS': '0x0', 08:54:14 INFO - 'XPC_SERVICE_NAME': '0', 08:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:54:17 INFO - Installing collected packages: mozsystemmonitor 08:54:17 INFO - Running setup.py install for mozsystemmonitor 08:54:17 INFO - Successfully installed mozsystemmonitor 08:54:17 INFO - Cleaning up... 08:54:17 INFO - Return code: 0 08:54:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:17 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:17 INFO - 'HOME': '/Users/cltbld', 08:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:17 INFO - 'LOGNAME': 'cltbld', 08:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:17 INFO - 'MOZ_NO_REMOTE': '1', 08:54:17 INFO - 'NO_EM_RESTART': '1', 08:54:17 INFO - 'PAGER': '/bin/cat', 08:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:17 INFO - 'PWD': '/builds/slave/test', 08:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:17 INFO - 'SHELL': '/bin/bash', 08:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:17 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:17 INFO - 'USER': 'cltbld', 08:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:17 INFO - 'XPC_FLAGS': '0x0', 08:54:17 INFO - 'XPC_SERVICE_NAME': '0', 08:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:17 INFO - Downloading/unpacking jsonschema==2.5.1 08:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:54:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:20 INFO - Downloading functools32-3.2.3-2.tar.gz 08:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:54:20 INFO - warning: no files found matching '*.txt' 08:54:20 INFO - no previously-included directories found matching 'build' 08:54:20 INFO - no previously-included directories found matching 'dist' 08:54:20 INFO - no previously-included directories found matching '.git*' 08:54:20 INFO - Installing collected packages: jsonschema, functools32 08:54:20 INFO - Running setup.py install for functools32 08:54:21 INFO - warning: no files found matching '*.txt' 08:54:21 INFO - no previously-included directories found matching 'build' 08:54:21 INFO - no previously-included directories found matching 'dist' 08:54:21 INFO - no previously-included directories found matching '.git*' 08:54:21 INFO - Successfully installed jsonschema functools32 08:54:21 INFO - Cleaning up... 08:54:21 INFO - Return code: 0 08:54:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:21 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:21 INFO - 'HOME': '/Users/cltbld', 08:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:21 INFO - 'LOGNAME': 'cltbld', 08:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:21 INFO - 'MOZ_NO_REMOTE': '1', 08:54:21 INFO - 'NO_EM_RESTART': '1', 08:54:21 INFO - 'PAGER': '/bin/cat', 08:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:21 INFO - 'PWD': '/builds/slave/test', 08:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:21 INFO - 'SHELL': '/bin/bash', 08:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:21 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:21 INFO - 'USER': 'cltbld', 08:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:21 INFO - 'XPC_FLAGS': '0x0', 08:54:21 INFO - 'XPC_SERVICE_NAME': '0', 08:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:54:21 INFO - Cleaning up... 08:54:21 INFO - Return code: 0 08:54:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:21 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:21 INFO - 'HOME': '/Users/cltbld', 08:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:21 INFO - 'LOGNAME': 'cltbld', 08:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:21 INFO - 'MOZ_NO_REMOTE': '1', 08:54:21 INFO - 'NO_EM_RESTART': '1', 08:54:21 INFO - 'PAGER': '/bin/cat', 08:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:21 INFO - 'PWD': '/builds/slave/test', 08:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:21 INFO - 'SHELL': '/bin/bash', 08:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:21 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:21 INFO - 'USER': 'cltbld', 08:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:21 INFO - 'XPC_FLAGS': '0x0', 08:54:21 INFO - 'XPC_SERVICE_NAME': '0', 08:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:24 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:54:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:25 INFO - Downloading docopt-0.6.1.tar.gz 08:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:25 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:25 INFO - Running setup.py install for blobuploader 08:54:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:54:25 INFO - Running setup.py install for requests 08:54:26 INFO - Running setup.py install for docopt 08:54:26 INFO - Successfully installed blobuploader requests docopt 08:54:26 INFO - Cleaning up... 08:54:26 INFO - Return code: 0 08:54:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:26 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:26 INFO - 'HOME': '/Users/cltbld', 08:54:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:26 INFO - 'LOGNAME': 'cltbld', 08:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:26 INFO - 'MOZ_NO_REMOTE': '1', 08:54:26 INFO - 'NO_EM_RESTART': '1', 08:54:26 INFO - 'PAGER': '/bin/cat', 08:54:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:26 INFO - 'PWD': '/builds/slave/test', 08:54:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:26 INFO - 'SHELL': '/bin/bash', 08:54:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:26 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:26 INFO - 'USER': 'cltbld', 08:54:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:26 INFO - 'XPC_FLAGS': '0x0', 08:54:26 INFO - 'XPC_SERVICE_NAME': '0', 08:54:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:26 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-6bMCXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:26 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-MDJ6aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:26 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-cKpfnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-BvvYoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-pyOW0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-aaWheN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-4l1SbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-s9Bg0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-rys0an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-JLM160-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-jBFrGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-iE2hUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:27 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-cw8YQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:28 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-08Rd_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:28 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-k2LRMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:28 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-idk7OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:28 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-PFjmo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:28 INFO - Running setup.py install for manifestparser 08:54:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:54:28 INFO - Running setup.py install for mozcrash 08:54:28 INFO - Running setup.py install for mozdebug 08:54:28 INFO - Running setup.py install for mozdevice 08:54:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Running setup.py install for mozfile 08:54:29 INFO - Running setup.py install for mozhttpd 08:54:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Running setup.py install for mozinfo 08:54:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Running setup.py install for mozInstall 08:54:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Running setup.py install for mozleak 08:54:29 INFO - Running setup.py install for mozlog 08:54:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:54:29 INFO - Running setup.py install for moznetwork 08:54:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:54:30 INFO - Running setup.py install for mozprocess 08:54:30 INFO - Running setup.py install for mozprofile 08:54:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:54:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:54:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:54:30 INFO - Running setup.py install for mozrunner 08:54:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:54:30 INFO - Running setup.py install for mozscreenshot 08:54:30 INFO - Running setup.py install for moztest 08:54:30 INFO - Running setup.py install for mozversion 08:54:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:54:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:31 INFO - Cleaning up... 08:54:31 INFO - Return code: 0 08:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:31 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:31 INFO - 'HOME': '/Users/cltbld', 08:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:31 INFO - 'LOGNAME': 'cltbld', 08:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:31 INFO - 'MOZ_NO_REMOTE': '1', 08:54:31 INFO - 'NO_EM_RESTART': '1', 08:54:31 INFO - 'PAGER': '/bin/cat', 08:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:31 INFO - 'PWD': '/builds/slave/test', 08:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:31 INFO - 'SHELL': '/bin/bash', 08:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:31 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:31 INFO - 'USER': 'cltbld', 08:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:31 INFO - 'XPC_FLAGS': '0x0', 08:54:31 INFO - 'XPC_SERVICE_NAME': '0', 08:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-_ZaxlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-y9OgVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-1yLgMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-HqMM9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-RyMT9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-RRpQyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-tptLTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-B7NYxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-70_8kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-R_ZbOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-XKhGE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-4zzEAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-a6uIik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-XDCUv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-5TC67S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-pp1g46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:33 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-7KSb4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:35 INFO - Downloading blessings-1.6.tar.gz 08:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:35 INFO - Installing collected packages: blessings 08:54:35 INFO - Running setup.py install for blessings 08:54:36 INFO - Successfully installed blessings 08:54:36 INFO - Cleaning up... 08:54:36 INFO - Return code: 0 08:54:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:36 INFO - Reading from file tmpfile_stdout 08:54:36 INFO - Current package versions: 08:54:36 INFO - blessings == 1.6 08:54:36 INFO - blobuploader == 1.2.4 08:54:36 INFO - docopt == 0.6.1 08:54:36 INFO - functools32 == 3.2.3-2 08:54:36 INFO - jsonschema == 2.5.1 08:54:36 INFO - manifestparser == 1.1 08:54:36 INFO - mozInstall == 1.12 08:54:36 INFO - mozcrash == 1.0 08:54:36 INFO - mozdebug == 0.1 08:54:36 INFO - mozdevice == 0.49 08:54:36 INFO - mozfile == 1.2 08:54:36 INFO - mozhttpd == 0.7 08:54:36 INFO - mozinfo == 0.9 08:54:36 INFO - mozleak == 0.1 08:54:36 INFO - mozlog == 3.4 08:54:36 INFO - moznetwork == 0.27 08:54:36 INFO - mozprocess == 0.24 08:54:36 INFO - mozprofile == 0.28 08:54:36 INFO - mozrunner == 6.13 08:54:36 INFO - mozscreenshot == 0.1 08:54:36 INFO - mozsystemmonitor == 0.3 08:54:36 INFO - moztest == 0.8 08:54:36 INFO - mozversion == 1.4 08:54:36 INFO - psutil == 3.1.1 08:54:36 INFO - requests == 1.2.3 08:54:36 INFO - wsgiref == 0.1.2 08:54:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:36 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 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:36 INFO - 'HOME': '/Users/cltbld', 08:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:36 INFO - 'LOGNAME': 'cltbld', 08:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:36 INFO - 'MOZ_NO_REMOTE': '1', 08:54:36 INFO - 'NO_EM_RESTART': '1', 08:54:36 INFO - 'PAGER': '/bin/cat', 08:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:36 INFO - 'PWD': '/builds/slave/test', 08:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:36 INFO - 'SHELL': '/bin/bash', 08:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:36 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:36 INFO - 'USER': 'cltbld', 08:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:36 INFO - 'XPC_FLAGS': '0x0', 08:54:36 INFO - 'XPC_SERVICE_NAME': '0', 08:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:54:36 INFO - Cleaning up... 08:54:36 INFO - Return code: 0 08:54:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad72dc0b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, '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.mAQKJJzBai/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.k3plXjwhDF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:36 INFO - 'HOME': '/Users/cltbld', 08:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:36 INFO - 'LOGNAME': 'cltbld', 08:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:36 INFO - 'MOZ_NO_REMOTE': '1', 08:54:36 INFO - 'NO_EM_RESTART': '1', 08:54:36 INFO - 'PAGER': '/bin/cat', 08:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:36 INFO - 'PWD': '/builds/slave/test', 08:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:36 INFO - 'SHELL': '/bin/bash', 08:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:36 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:36 INFO - 'USER': 'cltbld', 08:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:36 INFO - 'XPC_FLAGS': '0x0', 08:54:36 INFO - 'XPC_SERVICE_NAME': '0', 08:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:54:36 INFO - Cleaning up... 08:54:36 INFO - Return code: 0 08:54:36 INFO - Running post-action listener: _resource_record_post_action 08:54:36 INFO - Running post-action listener: _start_resource_monitoring 08:54:36 INFO - Starting resource monitoring. 08:54:36 INFO - [mozharness: 2017-02-22 16:54:36.983667Z] Finished create-virtualenv step (success) 08:54:36 INFO - [mozharness: 2017-02-22 16:54:36.984633Z] Running install step. 08:54:36 INFO - Running pre-action listener: _resource_record_pre_action 08:54:36 INFO - Running main action method: install 08:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:37 INFO - Reading from file tmpfile_stdout 08:54:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:54:37 INFO - Reading from file tmpfile_stdout 08:54:37 INFO - Output received: 08:54:37 INFO - Usage: mozinstall [options] installer 08:54:37 INFO - Options: 08:54:37 INFO - -h, --help show this help message and exit 08:54:37 INFO - -d DEST, --destination=DEST 08:54:37 INFO - Directory to install application into. [default: 08:54:37 INFO - "/builds/slave/test"] 08:54:37 INFO - --app=APP Application being installed. [default: firefox] 08:54:37 INFO - mkdir: /builds/slave/test/build/application 08:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:54:57 INFO - Reading from file tmpfile_stdout 08:54:57 INFO - Output received: 08:54:57 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:54:57 INFO - Running post-action listener: _resource_record_post_action 08:54:57 INFO - [mozharness: 2017-02-22 16:54:57.754666Z] Finished install step (success) 08:54:57 INFO - [mozharness: 2017-02-22 16:54:57.754796Z] Running run-tests step. 08:54:57 INFO - Running pre-action listener: _resource_record_pre_action 08:54:57 INFO - Running main action method: run_tests 08:54:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:57 INFO - 2017-02-22 08:54:57.767 screenresolution[1625:7385] starting screenresolution argv=screenresolution get 08:54:57 INFO - 2017-02-22 08:54:57.769 screenresolution[1625:7385] Display 0: 1600x1200x32@60 08:54:57 INFO - 2017-02-22 08:54:57.774 screenresolution[1626:7387] starting screenresolution argv=screenresolution list 08:54:57 INFO - Available Modes on Display 0 08:54:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:57 INFO - Intel Iris: 08:54:57 INFO - Chipset Model: Intel Iris 08:54:57 INFO - Type: GPU 08:54:57 INFO - Bus: Built-In 08:54:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:54:57 INFO - Vendor: Intel (0x8086) 08:54:57 INFO - Device ID: 0x0a2e 08:54:57 INFO - Revision ID: 0x0009 08:54:57 INFO - Displays: 08:54:57 INFO - Display: 08:54:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:57 INFO - Display Serial Number: 1600x1200 60 08:54:57 INFO - Main Display: Yes 08:54:57 INFO - Mirror: Off 08:54:57 INFO - Online: Yes 08:54:57 INFO - Rotation: Supported 08:54:57 INFO - Return code: 0 08:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:58 INFO - Python 2.7.3 08:54:58 INFO - Return code: 0 08:54:58 INFO - grabbing minidump binary from tooltool 08:54: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')]} 08:54:58 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 0x1087bfd30>, '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 0x1086e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087b4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:54:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:54:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:54:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:58 INFO - Return code: 0 08:54:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0288 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mAQKJJzBai/Render', 08:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:58 INFO - 'HOME': '/Users/cltbld', 08:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:58 INFO - 'LOGNAME': 'cltbld', 08:54:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:58 INFO - 'MOZ_NO_REMOTE': '1', 08:54:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:58 INFO - 'NO_EM_RESTART': '1', 08:54:58 INFO - 'PAGER': '/bin/cat', 08:54:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:58 INFO - 'PWD': '/builds/slave/test', 08:54:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:58 INFO - 'SHELL': '/bin/bash', 08:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3plXjwhDF/Listeners', 08:54:58 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 08:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:58 INFO - 'USER': 'cltbld', 08:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:58 INFO - 'XPC_FLAGS': '0x0', 08:54:58 INFO - 'XPC_SERVICE_NAME': '0', 08:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:54:58 INFO - mozversion application_buildid: 20170222065927 08:54:58 INFO - mozversion application_changeset: 8e4f44727c5bb84cd613de9ec81b8c65ca8c51c3 08:54:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:54:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:58 INFO - mozversion application_name: Firefox 08:54:58 INFO - mozversion application_remotingname: firefox-dev 08:54:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:54:58 INFO - mozversion application_vendor: Mozilla 08:54:58 INFO - mozversion application_version: 53.0a2 08:54:58 INFO - mozversion platform_buildid: 20170222065927 08:54:58 INFO - mozversion platform_changeset: 8e4f44727c5bb84cd613de9ec81b8c65ca8c51c3 08:54:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:54:58 INFO - mozversion platform_version: 53.0a2 08:54:58 INFO - using testdate: 1487782498 08:54:58 INFO - actual date: 1487782498 08:54:58 INFO - starting webserver on 'localhost:49246' 08:54:58 INFO - SUITE-START | Running 2 tests 08:54:58 INFO - TEST-START | dromaeo_css 08:54:58 INFO - operating with platform_type : mac_ 08:54:58 INFO - Initialising browser for dromaeo_css test... 08:54:58 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpJJDhAx/profile http://localhost:49246/getInfo.html) 08:55:00 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 08:55:00 INFO - PROCESS | 1636 | colorDepth:24 08:55:00 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 08:55:00 INFO - PROCESS | 1636 | __metrics 08:55:01 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:01 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:01 INFO - TEST-INFO | 1636: exit 0 08:55:01 INFO - Browser initialized. 08:55:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:55:02 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpJJDhAx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:14 INFO - PROCESS | 1638 | RSS: Main: 213532672 08:55:14 INFO - PROCESS | 1638 | 08:58:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 08:58:20 INFO - PROCESS | 1638 | RSS: Main: 358199296 08:58:20 INFO - PROCESS | 1638 | 09:00:04 INFO - PROCESS | 1638 | ************************* 09:00:04 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 09:00:04 INFO - PROCESS | 1638 | 09:00:04 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:04 INFO - PROCESS | 1638 | Full stack: 09:00:04 INFO - PROCESS | 1638 | ************************* 09:01:22 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 09:01:23 INFO - PROCESS | 1638 | RSS: Main: 354324480 09:01:23 INFO - PROCESS | 1638 | 09:04:25 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 09:04:26 INFO - PROCESS | 1638 | RSS: Main: 347529216 09:04:26 INFO - PROCESS | 1638 | 09:07:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 09:07:29 INFO - PROCESS | 1638 | RSS: Main: 336420864 09:07:29 INFO - PROCESS | 1638 | 09:10:32 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 09:10:33 INFO - PROCESS | 1638 | RSS: Main: 319172608 09:10:33 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 09:13:37 INFO - PROCESS | 1638 | RSS: Main: 499650560 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | __start_tp_report 09:13:37 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 09:13:37 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 09:13:37 INFO - PROCESS | 1638 | |i|pagename|runs| 09:13:37 INFO - PROCESS | 1638 | |0;dojo.html;3099.4730895747725;3399.762016658834;3410.880619178328;3419.213580876397;3450.5686789151355;5755.856103597413;5799.710014499279;5821.097729851869;5836.182934389183;5836.941630583693;5807.593468457209;5860.560457965659;5876.147958546008;5887.116932460122;5887.764489420418;5251.264822924784;5299.629025968184;5313.043652142613;5323.760430780605;5425.511703946644;4267.935980960288;4711.717296962193;5221.269022336875;5392.299001129848;5397.2443857859935;5232.398274198478;5289.418164001957;5291.417944026173;5319.308489896327;5349.197620356938;5345.33183352081;5352.33095863019;5353.03645343838;5357.678539287655;5364.30264065669;5107.387113546398;5197.454267301917;5289.86775330616;5294.973525132388;5329.9467005330225;5651;5727.541796656257;5742.483176514133;5783.334916484616;5811.622244554091;6316.210473690789;6344.619322840645;6364.968175159141;6381;6381.553291269613;6247.187865577446;6290;6295.2760432550385;6316.989281714904;6329.36706329368;5729.1119876419225;5832.329282132524;5837.737301821343;5868.471837534642;5948.167256584082;6314.747410103636;6318.62088274705;6322.71547780351;6334.049892516067;6346.650934198663;6301.495880329563;6310.5267104967315;6310.936890631035;6315;6321.873562528724;6215.440610345091;6276.870163370637;6288.402601752826;6350.428461438492;6373.980163173963;5241.580673546107;6214.067889816563;6221.3778622138325;6295.087212354183;6356.809295721136;6341.207349081365;6344.6827658616885;6356.77751278703;6357.809265722036;6361.9045714314325;4972.8756781080765;4985.426675932242;5026.648134630614;5045.192769156917;5073.315102461194;3892.5328960524917;4461.866144015685;4488.922658561922;4490.910181796346;4541.114482675846;5777.422257774189;5778.306603207642;5850.414958504116;5881.235439392852;5911.231539899872;5314.681119132787;6240.5319601030105;6264.498840092781;6273.341299163522;6275.529335299871;4854.563089321978;5585.6035991002245;5730.856728581819;5877.324107727581;5880.882382352329;5381.165919282517;5427.267318911975;5534.695591742493;5540.750666220029;5547.223388725582;5207.3230480037355;6184.907226391518;6229.12792209082;6255.218097737692;6309.936900631119;6323.810285691437;6328.841778955563;6330.303666596578;6357.777477788255;6373.362663733589;6301.527385446201;6314.336994615499;6318.336574659595;6319.526035547445;6320.525960553069;6132.141360525334;6133.273457575459;6241.344658810759;6301.086342480223;6308.148399965946;4701.177293973609;6208.844778880383;6258.217722784652;6291.716872740829;6318.526110541636;6140.600860944024;6234.314225435108;6261.405166509175;6265.906011409924;6299.929012068051;6136.171616831849;6140.0134868502855;6153.661548614869;6154.169187159676;6214.098955651315;6115.909724157246;6123.465646421213;6129.473148637757;6134.454201506325;6145.893739127;6238.6880655967925;6252.124702541557;6262.248530176408;6268.373162683877;6288.496920246461;5826.854328641818;5995.970020149872;5999.340072591924;6044.546659000681;6106.6336019838955 09:13:37 INFO - PROCESS | 1638 | |1;ext.html;488.9804407823687;497.4205051115451;508.76851032780087;525.2121817274088;548.7009579779022;29972;40080.79959600201;41671.79164104175;41906.37140442896;43779.3433098503;43874.341884871756;44251;44255.77872110635;44289.77855110728;44524;8383.832323353528;9272.350935434539;9496.097870702306;9505;9511.762205944837;8379.24586787189;11135;11343.943280283587;11348.886511134906;11595.652130436101;11336.376499292535;11398.772024559505;11402.372869492174;11415.657530274106;11432.085433165326;8399.580020998987;11393.886061139407;11452.599159029394;11455.942720286428;11480.483378247998;8406.24343809054;11086;11319.603813866557;11327.037201837853;11544.191906566544;41555.75332739992;41945.790271048754;41985;41985;42028.78985605083;3872.578390253639;3978.6817054635558;4035.9394609080887;4086.101057767316;4117.032497363117;27161.45677086467;29802;29871.253218669706;29876.954306599382;30791;3103.891363802256;3137.3882092991876;3306.93386132276;3394.4908263760385;3403.42141835886;489627;490461;490918;491090;492383;65262.34737652657;65419.34580654133;65690.34309656938;65945;65971.67014164898;69109.30890691129;69176.6541167291;69298.65350673316;69363;69393;16757.49727508177;16931.492055238363;16937;16941.407050753412;16944.57638559046;11644.126690498246;11943.940280298542;12852.971762258996;12882.484700612058;12921.612351629467;15917.602059948595;16064.598385040468;16072.35710571564;16080.758788618181;16089;4888.389080740018;6833.760818371433;7170.749023784142;7206.315400036988;7275.163356214103;758.2796343473611;796.4623878881731;877.1491653096614;877.4866702978701;878.15696930947;29840;30242.67330593633;30266.092017239516;30782.922597708974;31161.37677246488;1045.38844775807;1054.9314294570981;1058.6506452870535;1080.9243352965218;1095.2935356694886;15223.391064357302;15429.845701542841;15574.143422111665;15729.898907076395;16097;564322;569139;569260;569347;571547;54788.72605637026;54951.450485494635;54961.62595935134;55114.17328740072;55124.448755512734;1398.3008495752124;1438.0293302021093;1459.992700036493;1465.128248692048;1478.6672998575234;25266.862991165075;28388.574171387034;28466.430671386872;28718.856405717837;28893.711062889943;48162;48487;48609.5139048605;48688.75655621699;48706.512934870196;528245.0763238478;533100;533334;533380;534970;20056.498587534843;25246.747532525176;25318;25643;25648.871755641103;34868.65131348654;42782;43287.13425731531;43892.12215755731;44842.10315793731;31320.74717011294;32654.857080002086;35598.64401355953;36968.81515592405;37229;34757.65242347544;35046.59813607529;35153.296934060665;36257.63742362543;36486.27027459489;34435.82782086074;34868.128296792784;35403.114922127155;35614.8219258902;35791.28417431689;29355.55966660459;31037.689623104383;31275.687243128188;31381.215469613442;31407.528887066255;23571.76428235696;23797.762022379553;23852;23993;24111.758882411654 09:13:37 INFO - PROCESS | 1638 | |2;jquery.html;369.33150996695997;384.6499685286388;386.10231212431097;397.56665234893967;417.022083214861;14761.18813465259;15418;17779.822201777977;20494.795052049474;20693.793062069373;21369.786302136974;21697.566048679055;21706.581620740886;22009.33971980843;22140.446488837788;5643.238162848024;5688.800891968782;5803.274590676166;5834.358220595731;5911.379305172959;4172.499300083994;5783.652980821164;5885.646861188321;5886.852828679274;5893.410658934115;4351.521332653406;6232.470240029603;6488.61068335899;6523.282438931714;6579.572327798702;6309.274433440121;6461.3538646135485;6516.967415162894;6570.0801887735515;6587.209534855824;4917.286993385975;5747.3677895431465;5750.338711048241;5751.338596061423;5764.625299355528;24672.506549868904;25992;26259.474810503874;26574.804133813832;26629.866850665818;2766.1286694691107;2770.252031951362;2786.4148528808973;2826.1662809471254;2832.150354893524;15577.844221557752;15600.375984960589;15725.606859828482;15736.370545178293;16413.753793693104;1604.0696396090239;1739.852112570433;1797.640471905611;1798.7481752554652;1829.140304057091;116418.41790791077;126833.56082537159;127751;133919.33040334834;134544.6545534542;11725.006748852715;11729.765404691858;12091.395430228453;12121.151519393734;12221.877781222252;15959.760603590956;15975.680486390207;15996.200189990454;16004.359825607078;16010.9199454002;8777.90276215473;8909.376343656011;8916.19754222123;8966.775830604287;9096.317776166814;8769;8796.06486572953;8812.779680508038;8974.102589741104;9309.627614895464;4821.445533763592;4840.515948405202;4852.320675105488;4853.563179313879;4944.233643785219;1945.4260993007097;1976.4861136104428;2017.4351181669156;2018.2532462988495;2025.8480613953718;884.5533005832013;887.9422837515541;943.3302355327794;992.2409356842022;1027.660871912267;21523.816190109694;21695.132194712034;21905.233316833834;21946.122155113935;22042.33872983781;1031.7265924530006;1032.396048311731;1043.9269251152498;1046.6964580271788;1051.3113910388709;10185.490725463696;10810.189235807346;10882.347059176316;11736.58921937745;11754.823677644843;739879.3006034936;763216;768240;771897;780131;148363;148414.70608820784;152596.2370188142;153037;154738;974.28390133252;1019.4545917933722;1051.353417648141;1058.1323314881877;1059.920505962056;18118.5470363242;19906.303279385153;20478.97605119768;20496;20666.17335306631;43268.78365608152;60288.39711602828;60878.39121608905;61464;62662.74674506393;87164;88949;90040.5497972506;90580;91375.54312228662;7952.761417157494;8067.273945344947;8148.592570371339;8630.266427353494;8635.179657932485;9214.539273036455;12257.693557660774;12724.618261452171;13175.407106680414;13301.600951971457;11088.390138542134;11123.610673626385;11370.260933039326;11531.365774882463;11535.250208736405;8884.955575222082;11012.17408694335;11165.88834111681;11282.379469128948;11540.422978850856;11346.659600212008;11413.60052398162;11511.827322590336;11801.468933897824;11872.643820685393;8062.7581172564915;8240.681490961417;8407.915920840713;8420.705275315335;8574.09971952936;8345.248927596545;10914.672559823219;11331.716707082389;11345.41164237024;11679.182457227913 09:13:37 INFO - PROCESS | 1638 | |3;mootools.html;1431.105559025609;1441.4090223008568;1456.6431224350035;1457.3223451095241;1465.487079522167;7998.12020677725;8394.160583941602;8414.537200453973;8423.873641895369;8457.49255044697;7380.446466515006;7636.274553917383;7650.34972027377;7972.521648701082;8211.71259005935;2283.9657405138937;2329.7670232976734;2330.673705681206;2333.1717240379676;2337.9532409351805;2307.1348244408346;2330.3591512334074;2336.754640762721;2338.918137865175;2353.5881220786378;2306.192832508617;2324.2097686786487;2343.3672908314743;2343.61330380487;2349.377414985022;1972.0829814136496;2293.908243670251;2323.8605683659034;2323.918662846809;2325.813934885205;2265.2071774878827;2338.988305058464;2339.368370539945;2341.9531609367887;2346.6949296591506;8279.37904657147;8317.459365141247;8324.750257492286;8326.292265157468;8344.791380215482;5032.672876263031;5194.870128246786;5199.506046925574;5202.661826981272;5204.375474942994;3227.451333273349;3333.483310086916;3534.3284775892757;3540.4689296605457;3541.008517615046;1175.1362748379934;1175.5239128153025;1192.0165863162838;1195.0499353014375;1243.421808858876;10688.465576721133;10781.892181078245;10787;10789.62236321725;10811.351318920968;4202.768847713344;4447.3329000650165;4640.32715256286;4716.976415117902;4728.219843725816;9412;9415.670451534163;9420.858687119699;9423.199028082552;9427.198688111588;5038.2190760432195;5049.091163590516;5051.545360917535;5055.393352797688;5071.847844564669;3811.714121440903;4198.706090573692;4653.767311634405;4780.784864681098;4831.227003679394;3835.9041023974623;3863.768173909574;3904.2581909437117;3919.0594257378593;3951.6641085508054;1278.5525066226746;1281.116029939339;1286.395394164741;1295.4170623219588;1297.6626077219803;777.2616014785976;845.0535400351646;897.2597606974273;897.9461232326081;915.734437013272;4607.884802879955;5324.733763311819;5469.425710300441;5543.1685247213245;5706.229658995982;843.3506200225792;970.7767213540925;989.7281992639424;990.5592011554933;1034.963776267827;3683.1160521474653;3813.0657988792923;3827.8660246891227;3830.5211848518934;3886.805659717003;9441.15029647335;9857.802843943082;9939.950300248453;10015.649452269136;10047.598096076075;9978.251631127694;9983.700488985342;9986.151177150025;9999.300048996645;10097.091261786327;7737;7784.41616878725;7880.566568838769;7894.486858354074;7932.246436588515;4498;5241.6068794839775;5338;5408.486193811582;5659.518940889906;9121.45271283725;9162.358634895494;9167.724968250963;9277.768055798659;9322.48726320059;9070.118533355393;9313.674021409219;9444.433333999981;9483.573239204114;9503.144716975228;5646.407127251744;6243.531735119794;6451.774187903401;6453.612783233021;6824.078749368771;7629.847403052019;7794;7921.603919804102;8006.8398632025865;8015.47899386538;6945.610877824556;7138.928610713826;7186.784396468114;7237.782866514013;7272;6784.728610855511;6992.1259842519685;7013.719451221894;7146.606936618328;7235.602041887747;6240.906386404298;6334.588251763621;6413.070104834679;6419.679016049272;6425.293217746138;4909.116359055404;4930.975345123252;4968.205087186033;5010.624203184849;5021;4881.877953051202;4893.657443979029;4924.236743304794;4969.900601987868;5144.562712169508 09:13:37 INFO - PROCESS | 1638 | |4;prototype.html;343.309947006517;351.35877024430414;360.51690734415877;366.7579397597586;369.7116249325527;4156.854510092147;5285;5395.190721391793;5404.648697834638;5459.672419654824;4574.885627859305;5177.715225662597;5298.655587386817;5333.973330133344;5347.144456886899;3439.123023628971;4006.3389540725743;4171.707980441371;4236.428082208901;4270.658347332206;3105.1460848266793;4031.395290706388;4034.838606455753;4139.275626765319;4186.346393174694;3509.7543171977973;3825.9043523911846;3912.2957867583823;3993.700472464562;4001.6598589119812;4145.440365550642;4172.290710579194;4195.685323600712;4206.579342065785;4224.239636865363;3307.58655168104;3724.9813750931344;3739.1586892948867;3743.4651792765108;3765.851415318354;4653.464851542082;5214.400343960418;5219.373675159005;5229.764660590283;5299.311089558333;4188.220006497227;4578.702384345007;4649.256119020941;4649.5818775273865;4668.9261469861785;4571.451425828888;5177.611679124081;5674.319081710221;5684.8010319638615;5694.572907031989;3273.7544684148784;3761;3881.409696031188;3887.6695480883877;3915.941260881089;5512.751926163252;5584.5811564132855;5634.6337488063145;5873.794417195378;5877.177195192634;3771.8114094295174;3809.9809500952874;3875.069983204011;3908.179282350738;3919.7648141111627;3638.890833275006;3759.342115129841;3985.960140398617;3992.9001774955277;4002.8999275017777;4595.575371634804;4631.282151266559;4640.605548528413;4648.83729069481;4674.177070942335;4788.904221915543;5255.710935898563;5624.268845050117;5713.428657134336;5731.398203188689;1242.7079636285466;1275.5140261595138;1354.6477915741978;1370.8286464191976;1374.4845682868925;935.6736751237792;943.7640589852537;989.2580564576567;995.4624502768569;1008.3546530220665;4498.370228168059;5021.196608542616;5026.824061157842;5054.115529782273;5084.898302033938;4653.416869010843;4846.39420072491;5390.811321603725;5545.944540554543;5681.261436013375;4264.763218666552;4371.863315537983;4510.797653226813;4566.862994110182;5083.364579427572;2659.295286749013;2666.759886737623;2739.055026016021;2742.6708794944734;2898.3333833218476;5294.841154765363;5340.985212809632;5797.884042319214;5844.94155058444;5851.0983930222;4506.752128632891;4911.287863259879;5303.124984377535;5346;5777.566682498829;4912.778924948458;5309.415964244007;5686;5733.541316694738;5762.798302059492;4689.437267527782;5211.452797456364;5543.251661025871;5619.494245517923;5623.011492760197;4855.95144048555;5469.507744302873;5477.959732348426;5489.615726899079;5538.390777014606;4824.589909857701;5087.084324821568;5761.2222349983895;5845.532357411312;5924.733386997509;4041.595840415935;4148.564400737879;4174.77038762871;4177.099419763939;4198.39123327122;5164.746209887897;5635.746391412315;5818.468965999804;5854.707264636836;5871.295444546511;5508.813301890672;5542.533572560172;5553.972230138824;5625.606207565431;5626.184203290418;5603;5623.268975033219;5625.437456254342;5639.746211420578;5643.435656434323;4528.6377089833395;4862.565543164704;4977;5037.420696619935;5486.945130548644;4952.430470495795;5153.521373073236;5604.411536788579;5611.80358687444;5621.971890140687;4800.471948085638;5405.702686352131;5460.259722090381;5468.371137319259;5494.423085576117 09:13:37 INFO - PROCESS | 1638 | |5;yui.html;717.827721346877;755.964328869449;781.3866115099647;787.3976408047845;797.7487091566156;13696.246706431142;14126.717465650694;14354.856451435482;14901.180435076067;15697.21513924305;14166.504172353969;14215.289235538208;14308;14474.782878256809;14502.129872207648;839.290799274615;861.5046348349692;861.5606040919114;861.8448679237766;862.3316929379749;693.944484441246;712.8396110875063;866.9263112635433;870.3254977392539;871.4379225399614;746.779699988502;886.9911300887005;912.2929729459655;919.2691810011024;922.3912217936163;884.1600479544459;899.4827973915025;904.2675432899373;908.4004556992386;909.3043821476575;532.4489153725875;669.2537820330346;672.6199697171082;672.8856094463904;673.192169396726;12374.505019799197;14240.92879535606;14734.410623575044;14792.964492485531;15066.54800355991;10890.836637450444;14310.427582896671;14366.35351409189;14431.783523247159;14453.78319325211;11087.83368249477;11317.207795454322;11388.71528211793;11731.296122232694;12275.631731047994;3540.13041018667;3695.1870588470492;3770;3847.576766555677;3854.4411060396087;99434.99999999927;105196.47401762943;108148.4592577032;108490;109287.45356273168;10569.682909512727;10607.41659208751;10886.836697449544;11009;11308.151888608387;22725.772742272366;23174.1889033883;23180.65229021566;23212.41968950756;23214.071437142662;7387.1135463744695;7394.593297368697;7491.812704682427;7497.362724168507;7498.062742157231;3840.30874442603;4201.894952626148;4261.275583150872;4349;4458.754768487699;3535.275268569937;3592.2815436912724;3609.9639003609627;3619.49327094207;3642.417213245868;609.5306613907355;617.1051974636795;618.1593033474471;626.223482881233;629.7921685843661;573.6529399713197;611.788932818177;656.2617055812211;661.147120214927;662.4468568745152;9277.721668349961;9497.192738617296;10139.138173255356;10780.501129901351;11025.669229923114;565.1325215793819;573.4466240078344;592.7332700284803;636.2651137935692;694.7290556682898;4355.346697995263;4478.373027776114;4941.851744447672;4943.110240156806;4953.6037117030555;65184;93535;99064;100037.49981250193;103988.48005759923;86153.70769438463;89077;90343;92281;93897.530512347;74027.5194496107;74469.88295175685;74757.25242747612;76887;78202.21797782063;9108.180263776292;9506.47714375716;9552.188064014637;9555.569999349907;9649.807003860024;47459;48153.27770083521;50072.74963625159;51428.22857657213;52556.737216313675;69802.60394792177;70376.64811675908;70751.64624176847;72701;74656.25343746493;12265.152793354222;12638.684032899251;12749.553765618159;12824.358782061046;13367.930565554927;13654.863451365756;14302.031532901954;14454.855451445772;14512.637184070483;15043.6991260172;12401.75196496047;12688.87311126877;13473.124246923919;13742.381592828147;13755.79366309526;12340.321282329558;13355.230417039758;13360.860351664338;13505.527306544223;13701.862981370059;13005.154664946747;13048.086633935533;13061.673458163621;13183.53857614979;13698.794518082435;10254.846177307496;11056.557737690402;11143.849467601307;11148.554057837595;11382.317060976367;9238.538073096184;9359.743617902775;9545.120765276846;10776.730581735519;10785.514651840529 09:13:37 INFO - PROCESS | 1638 | __end_tp_report 09:13:37 INFO - PROCESS | 1638 | __start_cc_report 09:13:37 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1667 09:13:37 INFO - PROCESS | 1638 | __end_cc_report 09:13:37 INFO - PROCESS | 1638 | __startTimestamp1487783617547__endTimestamp 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | ------- Summary: start ------- 09:13:37 INFO - PROCESS | 1638 | Number of tests: 6 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5784.41 Median:6044.55 stddev:677.35 (11.2%) stddev-sans-first:645.85 09:13:37 INFO - PROCESS | 1638 | Values: 3099.5 3399.8 3410.9 3419.2 3450.6 5755.9 5799.7 5821.1 5836.2 5836.9 5807.6 5860.6 5876.1 5887.1 5887.8 5251.3 5299.6 5313.0 5323.8 5425.5 4267.9 4711.7 5221.3 5392.3 5397.2 5232.4 5289.4 5291.4 5319.3 5349.2 5345.3 5352.3 5353.0 5357.7 5364.3 5107.4 5197.5 5289.9 5295.0 5329.9 5651.0 5727.5 5742.5 5783.3 5811.6 6316.2 6344.6 6365.0 6381.0 6381.6 6247.2 6290.0 6295.3 6317.0 6329.4 5729.1 5832.3 5837.7 5868.5 5948.2 6314.7 6318.6 6322.7 6334.0 6346.7 6301.5 6310.5 6310.9 6315.0 6321.9 6215.4 6276.9 6288.4 6350.4 6374.0 5241.6 6214.1 6221.4 6295.1 6356.8 6341.2 6344.7 6356.8 6357.8 6361.9 4972.9 4985.4 5026.6 5045.2 5073.3 3892.5 4461.9 4488.9 4490.9 4541.1 5777.4 5778.3 5850.4 5881.2 5911.2 5314.7 6240.5 6264.5 6273.3 6275.5 4854.6 5585.6 5730.9 5877.3 5880.9 5381.2 5427.3 5534.7 5540.8 5547.2 5207.3 6184.9 6229.1 6255.2 6309.9 6323.8 6328.8 6330.3 6357.8 6373.4 6301.5 6314.3 6318.3 6319.5 6320.5 6132.1 6133.3 6241.3 6301.1 6308.1 4701.2 6208.8 6258.2 6291.7 6318.5 6140.6 6234.3 6261.4 6265.9 6299.9 6136.2 6140.0 6153.7 6154.2 6214.1 6115.9 6123.5 6129.5 6134.5 6145.9 6238.7 6252.1 6262.2 6268.4 6288.5 5826.9 5996.0 5999.3 6044.5 6106.6 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:66738.55 Median:35278.21 stddev:141749.45 (401.8%) stddev-sans-first:142059.82 09:13:37 INFO - PROCESS | 1638 | Values: 489.0 497.4 508.8 525.2 548.7 29972.0 40080.8 41671.8 41906.4 43779.3 43874.3 44251.0 44255.8 44289.8 44524.0 8383.8 9272.4 9496.1 9505.0 9511.8 8379.2 11135.0 11343.9 11348.9 11595.7 11336.4 11398.8 11402.4 11415.7 11432.1 8399.6 11393.9 11452.6 11455.9 11480.5 8406.2 11086.0 11319.6 11327.0 11544.2 41555.8 41945.8 41985.0 41985.0 42028.8 3872.6 3978.7 4035.9 4086.1 4117.0 27161.5 29802.0 29871.3 29877.0 30791.0 3103.9 3137.4 3306.9 3394.5 3403.4 489627.0 490461.0 490918.0 491090.0 492383.0 65262.3 65419.3 65690.3 65945.0 65971.7 69109.3 69176.7 69298.7 69363.0 69393.0 16757.5 16931.5 16937.0 16941.4 16944.6 11644.1 11943.9 12853.0 12882.5 12921.6 15917.6 16064.6 16072.4 16080.8 16089.0 4888.4 6833.8 7170.7 7206.3 7275.2 758.3 796.5 877.1 877.5 878.2 29840.0 30242.7 30266.1 30782.9 31161.4 1045.4 1054.9 1058.7 1080.9 1095.3 15223.4 15429.8 15574.1 15729.9 16097.0 564322.0 569139.0 569260.0 569347.0 571547.0 54788.7 54951.5 54961.6 55114.2 55124.4 1398.3 1438.0 1460.0 1465.1 1478.7 25266.9 28388.6 28466.4 28718.9 28893.7 48162.0 48487.0 48609.5 48688.8 48706.5 528245.1 533100.0 533334.0 533380.0 534970.0 20056.5 25246.7 25318.0 25643.0 25648.9 34868.7 42782.0 43287.1 43892.1 44842.1 31320.7 32654.9 35598.6 36968.8 37229.0 34757.7 35046.6 35153.3 36257.6 36486.3 34435.8 34868.1 35403.1 35614.8 35791.3 29355.6 31037.7 31275.7 31381.2 31407.5 23571.8 23797.8 23852.0 23993.0 24111.8 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:41357.16 Median:22091.39 stddev:127104.84 (575.4%) stddev-sans-first:127424.14 09:13:37 INFO - PROCESS | 1638 | Values: 369.3 384.6 386.1 397.6 417.0 14761.2 15418.0 17779.8 20494.8 20693.8 21369.8 21697.6 21706.6 22009.3 22140.4 5643.2 5688.8 5803.3 5834.4 5911.4 4172.5 5783.7 5885.6 5886.9 5893.4 4351.5 6232.5 6488.6 6523.3 6579.6 6309.3 6461.4 6517.0 6570.1 6587.2 4917.3 5747.4 5750.3 5751.3 5764.6 24672.5 25992.0 26259.5 26574.8 26629.9 2766.1 2770.3 2786.4 2826.2 2832.2 15577.8 15600.4 15725.6 15736.4 16413.8 1604.1 1739.9 1797.6 1798.7 1829.1 116418.4 126833.6 127751.0 133919.3 134544.7 11725.0 11729.8 12091.4 12121.2 12221.9 15959.8 15975.7 15996.2 16004.4 16010.9 8777.9 8909.4 8916.2 8966.8 9096.3 8769.0 8796.1 8812.8 8974.1 9309.6 4821.4 4840.5 4852.3 4853.6 4944.2 1945.4 1976.5 2017.4 2018.3 2025.8 884.6 887.9 943.3 992.2 1027.7 21523.8 21695.1 21905.2 21946.1 22042.3 1031.7 1032.4 1043.9 1046.7 1051.3 10185.5 10810.2 10882.3 11736.6 11754.8 739879.3 763216.0 768240.0 771897.0 780131.0 148363.0 148414.7 152596.2 153037.0 154738.0 974.3 1019.5 1051.4 1058.1 1059.9 18118.5 19906.3 20479.0 20496.0 20666.2 43268.8 60288.4 60878.4 61464.0 62662.7 87164.0 88949.0 90040.5 90580.0 91375.5 7952.8 8067.3 8148.6 8630.3 8635.2 9214.5 12257.7 12724.6 13175.4 13301.6 11088.4 11123.6 11370.3 11531.4 11535.3 8885.0 11012.2 11165.9 11282.4 11540.4 11346.7 11413.6 11511.8 11801.5 11872.6 8062.8 8240.7 8407.9 8420.7 8574.1 8345.2 10914.7 11331.7 11345.4 11679.2 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5384.54 Median:5108.21 stddev:2936.33 (57.5%) stddev-sans-first:2929.53 09:13:37 INFO - PROCESS | 1638 | Values: 1431.1 1441.4 1456.6 1457.3 1465.5 7998.1 8394.2 8414.5 8423.9 8457.5 7380.4 7636.3 7650.3 7972.5 8211.7 2284.0 2329.8 2330.7 2333.2 2338.0 2307.1 2330.4 2336.8 2338.9 2353.6 2306.2 2324.2 2343.4 2343.6 2349.4 1972.1 2293.9 2323.9 2323.9 2325.8 2265.2 2339.0 2339.4 2342.0 2346.7 8279.4 8317.5 8324.8 8326.3 8344.8 5032.7 5194.9 5199.5 5202.7 5204.4 3227.5 3333.5 3534.3 3540.5 3541.0 1175.1 1175.5 1192.0 1195.0 1243.4 10688.5 10781.9 10787.0 10789.6 10811.4 4202.8 4447.3 4640.3 4717.0 4728.2 9412.0 9415.7 9420.9 9423.2 9427.2 5038.2 5049.1 5051.5 5055.4 5071.8 3811.7 4198.7 4653.8 4780.8 4831.2 3835.9 3863.8 3904.3 3919.1 3951.7 1278.6 1281.1 1286.4 1295.4 1297.7 777.3 845.1 897.3 897.9 915.7 4607.9 5324.7 5469.4 5543.2 5706.2 843.4 970.8 989.7 990.6 1035.0 3683.1 3813.1 3827.9 3830.5 3886.8 9441.2 9857.8 9940.0 10015.6 10047.6 9978.3 9983.7 9986.2 9999.3 10097.1 7737.0 7784.4 7880.6 7894.5 7932.2 4498.0 5241.6 5338.0 5408.5 5659.5 9121.5 9162.4 9167.7 9277.8 9322.5 9070.1 9313.7 9444.4 9483.6 9503.1 5646.4 6243.5 6451.8 6453.6 6824.1 7629.8 7794.0 7921.6 8006.8 8015.5 6945.6 7138.9 7186.8 7237.8 7272.0 6784.7 6992.1 7013.7 7146.6 7235.6 6240.9 6334.6 6413.1 6419.7 6425.3 4909.1 4931.0 4968.2 5010.6 5021.0 4881.9 4893.7 4924.2 4969.9 5144.6 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4485.12 Median:4912.03 stddev:1339.01 (27.3%) stddev-sans-first:1306.18 09:13:37 INFO - PROCESS | 1638 | Values: 343.3 351.4 360.5 366.8 369.7 4156.9 5285.0 5395.2 5404.6 5459.7 4574.9 5177.7 5298.7 5334.0 5347.1 3439.1 4006.3 4171.7 4236.4 4270.7 3105.1 4031.4 4034.8 4139.3 4186.3 3509.8 3825.9 3912.3 3993.7 4001.7 4145.4 4172.3 4195.7 4206.6 4224.2 3307.6 3725.0 3739.2 3743.5 3765.9 4653.5 5214.4 5219.4 5229.8 5299.3 4188.2 4578.7 4649.3 4649.6 4668.9 4571.5 5177.6 5674.3 5684.8 5694.6 3273.8 3761.0 3881.4 3887.7 3915.9 5512.8 5584.6 5634.6 5873.8 5877.2 3771.8 3810.0 3875.1 3908.2 3919.8 3638.9 3759.3 3986.0 3992.9 4002.9 4595.6 4631.3 4640.6 4648.8 4674.2 4788.9 5255.7 5624.3 5713.4 5731.4 1242.7 1275.5 1354.6 1370.8 1374.5 935.7 943.8 989.3 995.5 1008.4 4498.4 5021.2 5026.8 5054.1 5084.9 4653.4 4846.4 5390.8 5545.9 5681.3 4264.8 4371.9 4510.8 4566.9 5083.4 2659.3 2666.8 2739.1 2742.7 2898.3 5294.8 5341.0 5797.9 5844.9 5851.1 4506.8 4911.3 5303.1 5346.0 5777.6 4912.8 5309.4 5686.0 5733.5 5762.8 4689.4 5211.5 5543.3 5619.5 5623.0 4856.0 5469.5 5478.0 5489.6 5538.4 4824.6 5087.1 5761.2 5845.5 5924.7 4041.6 4148.6 4174.8 4177.1 4198.4 5164.7 5635.7 5818.5 5854.7 5871.3 5508.8 5542.5 5554.0 5625.6 5626.2 5603.0 5623.3 5625.4 5639.7 5643.4 4528.6 4862.6 4977.0 5037.4 5486.9 4952.4 5153.5 5604.4 5611.8 5622.0 4800.5 5405.7 5460.3 5468.4 5494.4 09:13:37 INFO - PROCESS | 1638 | 09:13:37 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20174.89 Median:4407.05 stddev:28906.55 (655.9%) stddev-sans-first:28950.72 09:13:37 INFO - PROCESS | 1638 | Values: 717.8 756.0 781.4 787.4 797.7 13696.2 14126.7 14354.9 14901.2 15697.2 14166.5 14215.3 14308.0 14474.8 14502.1 839.3 861.5 861.6 861.8 862.3 693.9 712.8 866.9 870.3 871.4 746.8 887.0 912.3 919.3 922.4 884.2 899.5 904.3 908.4 909.3 532.4 669.3 672.6 672.9 673.2 12374.5 14240.9 14734.4 14793.0 15066.5 10890.8 14310.4 14366.4 14431.8 14453.8 11087.8 11317.2 11388.7 11731.3 12275.6 3540.1 3695.2 3770.0 3847.6 3854.4 99435.0 105196.5 108148.5 108490.0 109287.5 10569.7 10607.4 10886.8 11009.0 11308.2 22725.8 23174.2 23180.7 23212.4 23214.1 7387.1 7394.6 7491.8 7497.4 7498.1 3840.3 4201.9 4261.3 4349.0 4458.8 3535.3 3592.3 3610.0 3619.5 3642.4 609.5 617.1 618.2 626.2 629.8 573.7 611.8 656.3 661.1 662.4 9277.7 9497.2 10139.1 10780.5 11025.7 565.1 573.4 592.7 636.3 694.7 4355.3 4478.4 4941.9 4943.1 4953.6 65184.0 93535.0 99064.0 100037.5 103988.5 86153.7 89077.0 90343.0 92281.0 93897.5 74027.5 74469.9 74757.3 76887.0 78202.2 9108.2 9506.5 9552.2 9555.6 9649.8 47459.0 48153.3 50072.7 51428.2 52556.7 69802.6 70376.6 70751.6 72701.0 74656.3 12265.2 12638.7 12749.6 12824.4 13367.9 13654.9 14302.0 14454.9 14512.6 15043.7 12401.8 12688.9 13473.1 13742.4 13755.8 12340.3 13355.2 13360.9 13505.5 13701.9 13005.2 13048.1 13061.7 13183.5 13698.8 10254.8 11056.6 11143.8 11148.6 11382.3 9238.5 9359.7 9545.1 10776.7 10785.5 09:13:37 INFO - PROCESS | 1638 | -------- Summary: end -------- 09:13:37 INFO - PROCESS | 1638 | 09:13:38 INFO - TEST-INFO | 1638: exit 0 09:13:38 INFO - TEST-OK | dromaeo_css | took 1119835ms 09:13:38 INFO - TEST-START | kraken 09:13:38 INFO - operating with platform_type : mac_ 09:13:38 INFO - Initialising browser for kraken test... 09:13:38 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpcjcMZF/profile http://localhost:49246/getInfo.html) 09:13:40 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 09:13:40 INFO - PROCESS | 1647 | colorDepth:24 09:13:40 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 09:13:40 INFO - PROCESS | 1647 | __metrics 09:13:40 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:40 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:41 INFO - TEST-INFO | 1647: exit 0 09:13:41 INFO - Browser initialized. 09:13:41 INFO - Running cycle 1/1 for kraken test... 09:13:41 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpcjcMZF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:53 INFO - PROCESS | 1648 | RSS: Main: 213426176 09:13:53 INFO - PROCESS | 1648 | 09:13:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:57 INFO - PROCESS | 1648 | RSS: Main: 266629120 09:13:57 INFO - PROCESS | 1648 | 09:13:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 09:14:00 INFO - PROCESS | 1648 | RSS: Main: 275128320 09:14:00 INFO - PROCESS | 1648 | 09:14:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 09:14:04 INFO - PROCESS | 1648 | RSS: Main: 373411840 09:14:04 INFO - PROCESS | 1648 | 09:14:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 09:14:06 INFO - PROCESS | 1648 | RSS: Main: 276230144 09:14:06 INFO - PROCESS | 1648 | 09:14:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:09 INFO - PROCESS | 1648 | RSS: Main: 277495808 09:14:09 INFO - PROCESS | 1648 | 09:14:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:12 INFO - PROCESS | 1648 | RSS: Main: 317431808 09:14:12 INFO - PROCESS | 1648 | 09:14:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:16 INFO - PROCESS | 1648 | RSS: Main: 317747200 09:14:16 INFO - PROCESS | 1648 | 09:14:19 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 09:14:20 INFO - PROCESS | 1648 | RSS: Main: 313819136 09:14:20 INFO - PROCESS | 1648 | 09:14:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:22 INFO - PROCESS | 1648 | RSS: Main: 295149568 09:14:22 INFO - PROCESS | 1648 | 09:14:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:24 INFO - PROCESS | 1648 | RSS: Main: 299933696 09:14:24 INFO - PROCESS | 1648 | 09:14:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:27 INFO - PROCESS | 1648 | RSS: Main: 301813760 09:14:27 INFO - PROCESS | 1648 | 09:14:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:31 INFO - PROCESS | 1648 | RSS: Main: 316104704 09:14:31 INFO - PROCESS | 1648 | 09:14:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:34 INFO - PROCESS | 1648 | RSS: Main: 309084160 09:14:34 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 09:14:36 INFO - PROCESS | 1648 | RSS: Main: 353943552 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | __start_tp_report 09:14:36 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 09:14:36 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 09:14:36 INFO - PROCESS | 1648 | |i|pagename|runs| 09:14:36 INFO - PROCESS | 1648 | |0;ai-astar;118;164;171;115;116;115;116;115;114;115 09:14:36 INFO - PROCESS | 1648 | |1;audio-beat-detection;171;95;110;143;108;111;110;109;133;139 09:14:36 INFO - PROCESS | 1648 | |2;audio-dft;184;184;181;188;184;184;185;186;182;186 09:14:36 INFO - PROCESS | 1648 | |3;audio-fft;82;59;58;90;61;59;58;60;73;58 09:14:36 INFO - PROCESS | 1648 | |4;audio-oscillator;90;69;85;70;67;69;104;98;79;81 09:14:36 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;91;88;91;89;91;88;91;88;91;87 09:14:36 INFO - PROCESS | 1648 | |6;imaging-darkroom;100;99;100;100;100;101;101;100;101;101 09:14:36 INFO - PROCESS | 1648 | |7;imaging-desaturate;86;106;114;87;87;88;85;86;101;133 09:14:36 INFO - PROCESS | 1648 | |8;json-parse-financial;56;53;53;52;55;56;57;55;56;55 09:14:36 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;66;77;73;75;72;67;71;69;68;68 09:14:36 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;83;84;84;84;86;83;83;87;88;83 09:14:36 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;138;145;138;137;137;146;154;156;177;137 09:14:36 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;171;173;170;177;232;149;207;236;217;169 09:14:36 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;66;66;66;64;65 09:14:36 INFO - PROCESS | 1648 | __end_tp_report 09:14:36 INFO - PROCESS | 1648 | __start_cc_report 09:14:36 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2069 09:14:36 INFO - PROCESS | 1648 | __end_cc_report 09:14:36 INFO - PROCESS | 1648 | __startTimestamp1487783676858__endTimestamp 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | ------- Summary: start ------- 09:14:36 INFO - PROCESS | 1648 | Number of tests: 14 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:125.90 Median:116.00 stddev:22.01 (19.0%) stddev-sans-first:23.16 09:14:36 INFO - PROCESS | 1648 | Values: 118.0 164.0 171.0 115.0 116.0 115.0 116.0 115.0 114.0 115.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:136.00 stddev:22.97 (16.9%) stddev-sans-first:16.49 09:14:36 INFO - PROCESS | 1648 | Values: 171.0 95.0 110.0 143.0 108.0 111.0 110.0 109.0 133.0 139.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:2.01 (1.1%) stddev-sans-first:2.13 09:14:36 INFO - PROCESS | 1648 | Values: 184.0 184.0 181.0 188.0 184.0 184.0 185.0 186.0 182.0 186.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:11.70 (19.3%) stddev-sans-first:10.84 09:14:36 INFO - PROCESS | 1648 | Values: 82.0 59.0 58.0 90.0 61.0 59.0 58.0 60.0 73.0 58.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:80.00 stddev:13.01 (16.3%) stddev-sans-first:13.41 09:14:36 INFO - PROCESS | 1648 | Values: 90.0 69.0 85.0 70.0 67.0 69.0 104.0 98.0 79.0 81.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:91.00 stddev:1.65 (1.8%) stddev-sans-first:1.66 09:14:36 INFO - PROCESS | 1648 | Values: 91.0 88.0 91.0 89.0 91.0 88.0 91.0 88.0 91.0 87.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:101.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:14:36 INFO - PROCESS | 1648 | Values: 100.0 99.0 100.0 100.0 100.0 101.0 101.0 100.0 101.0 101.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:86.00 stddev:16.15 (18.8%) stddev-sans-first:16.61 09:14:36 INFO - PROCESS | 1648 | Values: 86.0 106.0 114.0 87.0 87.0 88.0 85.0 86.0 101.0 133.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.50 stddev:1.62 (2.9%) stddev-sans-first:1.66 09:14:36 INFO - PROCESS | 1648 | Values: 56.0 53.0 53.0 52.0 55.0 56.0 57.0 55.0 56.0 55.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.50 stddev:3.63 (5.1%) stddev-sans-first:3.44 09:14:36 INFO - PROCESS | 1648 | Values: 66.0 77.0 73.0 75.0 72.0 67.0 71.0 69.0 68.0 68.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:1.84 (2.2%) stddev-sans-first:1.87 09:14:36 INFO - PROCESS | 1648 | Values: 83.0 84.0 84.0 84.0 86.0 83.0 83.0 87.0 88.0 83.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:145.50 stddev:12.89 (8.9%) stddev-sans-first:13.30 09:14:36 INFO - PROCESS | 1648 | Values: 138.0 145.0 138.0 137.0 137.0 146.0 154.0 156.0 177.0 137.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.10 Median:192.00 stddev:30.26 (15.8%) stddev-sans-first:31.29 09:14:36 INFO - PROCESS | 1648 | Values: 171.0 173.0 170.0 177.0 232.0 149.0 207.0 236.0 217.0 169.0 09:14:36 INFO - PROCESS | 1648 | 09:14:36 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 09:14:36 INFO - PROCESS | 1648 | Values: 67.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 64.0 65.0 09:14:36 INFO - PROCESS | 1648 | -------- Summary: end -------- 09:14:36 INFO - PROCESS | 1648 | 09:14:37 INFO - TEST-INFO | 1648: exit 0 09:14:37 INFO - TEST-OK | kraken | took 59611ms 09:14:37 INFO - SUITE-END | took 1179s 09:14:38 INFO - Completed test suite (00:19:39) 09:14:38 INFO - javascript benchmark 09:14:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.4730895747725, 3399.762016658834, 3410.880619178328, 3419.213580876397, 3450.5686789151355, 5755.856103597413, 5799.710014499279, 5821.097729851869, 5836.182934389183, 5836.941630583693, 5807.593468457209, 5860.560457965659, 5876.147958546008, 5887.116932460122, 5887.764489420418, 5251.264822924784, 5299.629025968184, 5313.043652142613, 5323.760430780605, 5425.511703946644, 4267.935980960288, 4711.717296962193, 5221.269022336875, 5392.299001129848, 5397.2443857859935, 5232.398274198478, 5289.418164001957, 5291.417944026173, 5319.308489896327, 5349.197620356938, 5345.33183352081, 5352.33095863019, 5353.03645343838, 5357.678539287655, 5364.30264065669, 5107.387113546398, 5197.454267301917, 5289.86775330616, 5294.973525132388, 5329.9467005330225, 5651.0, 5727.541796656257, 5742.483176514133, 5783.334916484616, 5811.622244554091, 6316.210473690789, 6344.619322840645, 6364.968175159141, 6381.0, 6381.553291269613, 6247.187865577446, 6290.0, 6295.2760432550385, 6316.989281714904, 6329.36706329368, 5729.1119876419225, 5832.329282132524, 5837.737301821343, 5868.471837534642, 5948.167256584082, 6314.747410103636, 6318.62088274705, 6322.71547780351, 6334.049892516067, 6346.650934198663, 6301.495880329563, 6310.5267104967315, 6310.936890631035, 6315.0, 6321.873562528724, 6215.440610345091, 6276.870163370637, 6288.402601752826, 6350.428461438492, 6373.980163173963, 5241.580673546107, 6214.067889816563, 6221.3778622138325, 6295.087212354183, 6356.809295721136, 6341.207349081365, 6344.6827658616885, 6356.77751278703, 6357.809265722036, 6361.9045714314325, 4972.8756781080765, 4985.426675932242, 5026.648134630614, 5045.192769156917, 5073.315102461194, 3892.5328960524917, 4461.866144015685, 4488.922658561922, 4490.910181796346, 4541.114482675846, 5777.422257774189, 5778.306603207642, 5850.414958504116, 5881.235439392852, 5911.231539899872, 5314.681119132787, 6240.5319601030105, 6264.498840092781, 6273.341299163522, 6275.529335299871, 4854.563089321978, 5585.6035991002245, 5730.856728581819, 5877.324107727581, 5880.882382352329, 5381.165919282517, 5427.267318911975, 5534.695591742493, 5540.750666220029, 5547.223388725582, 5207.3230480037355, 6184.907226391518, 6229.12792209082, 6255.218097737692, 6309.936900631119, 6323.810285691437, 6328.841778955563, 6330.303666596578, 6357.777477788255, 6373.362663733589, 6301.527385446201, 6314.336994615499, 6318.336574659595, 6319.526035547445, 6320.525960553069, 6132.141360525334, 6133.273457575459, 6241.344658810759, 6301.086342480223, 6308.148399965946, 4701.177293973609, 6208.844778880383, 6258.217722784652, 6291.716872740829, 6318.526110541636, 6140.600860944024, 6234.314225435108, 6261.405166509175, 6265.906011409924, 6299.929012068051, 6136.171616831849, 6140.0134868502855, 6153.661548614869, 6154.169187159676, 6214.098955651315, 6115.909724157246, 6123.465646421213, 6129.473148637757, 6134.454201506325, 6145.893739127, 6238.6880655967925, 6252.124702541557, 6262.248530176408, 6268.373162683877, 6288.496920246461, 5826.854328641818, 5995.970020149872, 5999.340072591924, 6044.546659000681, 6106.6336019838955], "value": 5741.303745348029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.9804407823687, 497.4205051115451, 508.76851032780087, 525.2121817274088, 548.7009579779022, 29972.0, 40080.79959600201, 41671.79164104175, 41906.37140442896, 43779.3433098503, 43874.341884871756, 44251.0, 44255.77872110635, 44289.77855110728, 44524.0, 8383.832323353528, 9272.350935434539, 9496.097870702306, 9505.0, 9511.762205944837, 8379.24586787189, 11135.0, 11343.943280283587, 11348.886511134906, 11595.652130436101, 11336.376499292535, 11398.772024559505, 11402.372869492174, 11415.657530274106, 11432.085433165326, 8399.580020998987, 11393.886061139407, 11452.599159029394, 11455.942720286428, 11480.483378247998, 8406.24343809054, 11086.0, 11319.603813866557, 11327.037201837853, 11544.191906566544, 41555.75332739992, 41945.790271048754, 41985.0, 41985.0, 42028.78985605083, 3872.578390253639, 3978.6817054635558, 4035.9394609080887, 4086.101057767316, 4117.032497363117, 27161.45677086467, 29802.0, 29871.253218669706, 29876.954306599382, 30791.0, 3103.891363802256, 3137.3882092991876, 3306.93386132276, 3394.4908263760385, 3403.42141835886, 489627.0, 490461.0, 490918.0, 491090.0, 492383.0, 65262.34737652657, 65419.34580654133, 65690.34309656938, 65945.0, 65971.67014164898, 69109.30890691129, 69176.6541167291, 69298.65350673316, 69363.0, 69393.0, 16757.49727508177, 16931.492055238363, 16937.0, 16941.407050753412, 16944.57638559046, 11644.126690498246, 11943.940280298542, 12852.971762258996, 12882.484700612058, 12921.612351629467, 15917.602059948595, 16064.598385040468, 16072.35710571564, 16080.758788618181, 16089.0, 4888.389080740018, 6833.760818371433, 7170.749023784142, 7206.315400036988, 7275.163356214103, 758.2796343473611, 796.4623878881731, 877.1491653096614, 877.4866702978701, 878.15696930947, 29840.0, 30242.67330593633, 30266.092017239516, 30782.922597708974, 31161.37677246488, 1045.38844775807, 1054.9314294570981, 1058.6506452870535, 1080.9243352965218, 1095.2935356694886, 15223.391064357302, 15429.845701542841, 15574.143422111665, 15729.898907076395, 16097.0, 564322.0, 569139.0, 569260.0, 569347.0, 571547.0, 54788.72605637026, 54951.450485494635, 54961.62595935134, 55114.17328740072, 55124.448755512734, 1398.3008495752124, 1438.0293302021093, 1459.992700036493, 1465.128248692048, 1478.6672998575234, 25266.862991165075, 28388.574171387034, 28466.430671386872, 28718.856405717837, 28893.711062889943, 48162.0, 48487.0, 48609.5139048605, 48688.75655621699, 48706.512934870196, 528245.0763238478, 533100.0, 533334.0, 533380.0, 534970.0, 20056.498587534843, 25246.747532525176, 25318.0, 25643.0, 25648.871755641103, 34868.65131348654, 42782.0, 43287.13425731531, 43892.12215755731, 44842.10315793731, 31320.74717011294, 32654.857080002086, 35598.64401355953, 36968.81515592405, 37229.0, 34757.65242347544, 35046.59813607529, 35153.296934060665, 36257.63742362543, 36486.27027459489, 34435.82782086074, 34868.128296792784, 35403.114922127155, 35614.8219258902, 35791.28417431689, 29355.55966660459, 31037.689623104383, 31275.687243128188, 31381.215469613442, 31407.528887066255, 23571.76428235696, 23797.762022379553, 23852.0, 23993.0, 24111.758882411654], "value": 19756.90606034408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.33150996695997, 384.6499685286388, 386.10231212431097, 397.56665234893967, 417.022083214861, 14761.18813465259, 15418.0, 17779.822201777977, 20494.795052049474, 20693.793062069373, 21369.786302136974, 21697.566048679055, 21706.581620740886, 22009.33971980843, 22140.446488837788, 5643.238162848024, 5688.800891968782, 5803.274590676166, 5834.358220595731, 5911.379305172959, 4172.499300083994, 5783.652980821164, 5885.646861188321, 5886.852828679274, 5893.410658934115, 4351.521332653406, 6232.470240029603, 6488.61068335899, 6523.282438931714, 6579.572327798702, 6309.274433440121, 6461.3538646135485, 6516.967415162894, 6570.0801887735515, 6587.209534855824, 4917.286993385975, 5747.3677895431465, 5750.338711048241, 5751.338596061423, 5764.625299355528, 24672.506549868904, 25992.0, 26259.474810503874, 26574.804133813832, 26629.866850665818, 2766.1286694691107, 2770.252031951362, 2786.4148528808973, 2826.1662809471254, 2832.150354893524, 15577.844221557752, 15600.375984960589, 15725.606859828482, 15736.370545178293, 16413.753793693104, 1604.0696396090239, 1739.852112570433, 1797.640471905611, 1798.7481752554652, 1829.140304057091, 116418.41790791077, 126833.56082537159, 127751.0, 133919.33040334834, 134544.6545534542, 11725.006748852715, 11729.765404691858, 12091.395430228453, 12121.151519393734, 12221.877781222252, 15959.760603590956, 15975.680486390207, 15996.200189990454, 16004.359825607078, 16010.9199454002, 8777.90276215473, 8909.376343656011, 8916.19754222123, 8966.775830604287, 9096.317776166814, 8769.0, 8796.06486572953, 8812.779680508038, 8974.102589741104, 9309.627614895464, 4821.445533763592, 4840.515948405202, 4852.320675105488, 4853.563179313879, 4944.233643785219, 1945.4260993007097, 1976.4861136104428, 2017.4351181669156, 2018.2532462988495, 2025.8480613953718, 884.5533005832013, 887.9422837515541, 943.3302355327794, 992.2409356842022, 1027.660871912267, 21523.816190109694, 21695.132194712034, 21905.233316833834, 21946.122155113935, 22042.33872983781, 1031.7265924530006, 1032.396048311731, 1043.9269251152498, 1046.6964580271788, 1051.3113910388709, 10185.490725463696, 10810.189235807346, 10882.347059176316, 11736.58921937745, 11754.823677644843, 739879.3006034936, 763216.0, 768240.0, 771897.0, 780131.0, 148363.0, 148414.70608820784, 152596.2370188142, 153037.0, 154738.0, 974.28390133252, 1019.4545917933722, 1051.353417648141, 1058.1323314881877, 1059.920505962056, 18118.5470363242, 19906.303279385153, 20478.97605119768, 20496.0, 20666.17335306631, 43268.78365608152, 60288.39711602828, 60878.39121608905, 61464.0, 62662.74674506393, 87164.0, 88949.0, 90040.5497972506, 90580.0, 91375.54312228662, 7952.761417157494, 8067.273945344947, 8148.592570371339, 8630.266427353494, 8635.179657932485, 9214.539273036455, 12257.693557660774, 12724.618261452171, 13175.407106680414, 13301.600951971457, 11088.390138542134, 11123.610673626385, 11370.260933039326, 11531.365774882463, 11535.250208736405, 8884.955575222082, 11012.17408694335, 11165.88834111681, 11282.379469128948, 11540.422978850856, 11346.659600212008, 11413.60052398162, 11511.827322590336, 11801.468933897824, 11872.643820685393, 8062.7581172564915, 8240.681490961417, 8407.915920840713, 8420.705275315335, 8574.09971952936, 8345.248927596545, 10914.672559823219, 11331.716707082389, 11345.41164237024, 11679.182457227913], "value": 10118.269206408226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.105559025609, 1441.4090223008568, 1456.6431224350035, 1457.3223451095241, 1465.487079522167, 7998.12020677725, 8394.160583941602, 8414.537200453973, 8423.873641895369, 8457.49255044697, 7380.446466515006, 7636.274553917383, 7650.34972027377, 7972.521648701082, 8211.71259005935, 2283.9657405138937, 2329.7670232976734, 2330.673705681206, 2333.1717240379676, 2337.9532409351805, 2307.1348244408346, 2330.3591512334074, 2336.754640762721, 2338.918137865175, 2353.5881220786378, 2306.192832508617, 2324.2097686786487, 2343.3672908314743, 2343.61330380487, 2349.377414985022, 1972.0829814136496, 2293.908243670251, 2323.8605683659034, 2323.918662846809, 2325.813934885205, 2265.2071774878827, 2338.988305058464, 2339.368370539945, 2341.9531609367887, 2346.6949296591506, 8279.37904657147, 8317.459365141247, 8324.750257492286, 8326.292265157468, 8344.791380215482, 5032.672876263031, 5194.870128246786, 5199.506046925574, 5202.661826981272, 5204.375474942994, 3227.451333273349, 3333.483310086916, 3534.3284775892757, 3540.4689296605457, 3541.008517615046, 1175.1362748379934, 1175.5239128153025, 1192.0165863162838, 1195.0499353014375, 1243.421808858876, 10688.465576721133, 10781.892181078245, 10787.0, 10789.62236321725, 10811.351318920968, 4202.768847713344, 4447.3329000650165, 4640.32715256286, 4716.976415117902, 4728.219843725816, 9412.0, 9415.670451534163, 9420.858687119699, 9423.199028082552, 9427.198688111588, 5038.2190760432195, 5049.091163590516, 5051.545360917535, 5055.393352797688, 5071.847844564669, 3811.714121440903, 4198.706090573692, 4653.767311634405, 4780.784864681098, 4831.227003679394, 3835.9041023974623, 3863.768173909574, 3904.2581909437117, 3919.0594257378593, 3951.6641085508054, 1278.5525066226746, 1281.116029939339, 1286.395394164741, 1295.4170623219588, 1297.6626077219803, 777.2616014785976, 845.0535400351646, 897.2597606974273, 897.9461232326081, 915.734437013272, 4607.884802879955, 5324.733763311819, 5469.425710300441, 5543.1685247213245, 5706.229658995982, 843.3506200225792, 970.7767213540925, 989.7281992639424, 990.5592011554933, 1034.963776267827, 3683.1160521474653, 3813.0657988792923, 3827.8660246891227, 3830.5211848518934, 3886.805659717003, 9441.15029647335, 9857.802843943082, 9939.950300248453, 10015.649452269136, 10047.598096076075, 9978.251631127694, 9983.700488985342, 9986.151177150025, 9999.300048996645, 10097.091261786327, 7737.0, 7784.41616878725, 7880.566568838769, 7894.486858354074, 7932.246436588515, 4498.0, 5241.6068794839775, 5338.0, 5408.486193811582, 5659.518940889906, 9121.45271283725, 9162.358634895494, 9167.724968250963, 9277.768055798659, 9322.48726320059, 9070.118533355393, 9313.674021409219, 9444.433333999981, 9483.573239204114, 9503.144716975228, 5646.407127251744, 6243.531735119794, 6451.774187903401, 6453.612783233021, 6824.078749368771, 7629.847403052019, 7794.0, 7921.603919804102, 8006.8398632025865, 8015.47899386538, 6945.610877824556, 7138.928610713826, 7186.784396468114, 7237.782866514013, 7272.0, 6784.728610855511, 6992.1259842519685, 7013.719451221894, 7146.606936618328, 7235.602041887747, 6240.906386404298, 6334.588251763621, 6413.070104834679, 6419.679016049272, 6425.293217746138, 4909.116359055404, 4930.975345123252, 4968.205087186033, 5010.624203184849, 5021.0, 4881.877953051202, 4893.657443979029, 4924.236743304794, 4969.900601987868, 5144.562712169508], "value": 4389.443244673383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.309947006517, 351.35877024430414, 360.51690734415877, 366.7579397597586, 369.7116249325527, 4156.854510092147, 5285.0, 5395.190721391793, 5404.648697834638, 5459.672419654824, 4574.885627859305, 5177.715225662597, 5298.655587386817, 5333.973330133344, 5347.144456886899, 3439.123023628971, 4006.3389540725743, 4171.707980441371, 4236.428082208901, 4270.658347332206, 3105.1460848266793, 4031.395290706388, 4034.838606455753, 4139.275626765319, 4186.346393174694, 3509.7543171977973, 3825.9043523911846, 3912.2957867583823, 3993.700472464562, 4001.6598589119812, 4145.440365550642, 4172.290710579194, 4195.685323600712, 4206.579342065785, 4224.239636865363, 3307.58655168104, 3724.9813750931344, 3739.1586892948867, 3743.4651792765108, 3765.851415318354, 4653.464851542082, 5214.400343960418, 5219.373675159005, 5229.764660590283, 5299.311089558333, 4188.220006497227, 4578.702384345007, 4649.256119020941, 4649.5818775273865, 4668.9261469861785, 4571.451425828888, 5177.611679124081, 5674.319081710221, 5684.8010319638615, 5694.572907031989, 3273.7544684148784, 3761.0, 3881.409696031188, 3887.6695480883877, 3915.941260881089, 5512.751926163252, 5584.5811564132855, 5634.6337488063145, 5873.794417195378, 5877.177195192634, 3771.8114094295174, 3809.9809500952874, 3875.069983204011, 3908.179282350738, 3919.7648141111627, 3638.890833275006, 3759.342115129841, 3985.960140398617, 3992.9001774955277, 4002.8999275017777, 4595.575371634804, 4631.282151266559, 4640.605548528413, 4648.83729069481, 4674.177070942335, 4788.904221915543, 5255.710935898563, 5624.268845050117, 5713.428657134336, 5731.398203188689, 1242.7079636285466, 1275.5140261595138, 1354.6477915741978, 1370.8286464191976, 1374.4845682868925, 935.6736751237792, 943.7640589852537, 989.2580564576567, 995.4624502768569, 1008.3546530220665, 4498.370228168059, 5021.196608542616, 5026.824061157842, 5054.115529782273, 5084.898302033938, 4653.416869010843, 4846.39420072491, 5390.811321603725, 5545.944540554543, 5681.261436013375, 4264.763218666552, 4371.863315537983, 4510.797653226813, 4566.862994110182, 5083.364579427572, 2659.295286749013, 2666.759886737623, 2739.055026016021, 2742.6708794944734, 2898.3333833218476, 5294.841154765363, 5340.985212809632, 5797.884042319214, 5844.94155058444, 5851.0983930222, 4506.752128632891, 4911.287863259879, 5303.124984377535, 5346.0, 5777.566682498829, 4912.778924948458, 5309.415964244007, 5686.0, 5733.541316694738, 5762.798302059492, 4689.437267527782, 5211.452797456364, 5543.251661025871, 5619.494245517923, 5623.011492760197, 4855.95144048555, 5469.507744302873, 5477.959732348426, 5489.615726899079, 5538.390777014606, 4824.589909857701, 5087.084324821568, 5761.2222349983895, 5845.532357411312, 5924.733386997509, 4041.595840415935, 4148.564400737879, 4174.77038762871, 4177.099419763939, 4198.39123327122, 5164.746209887897, 5635.746391412315, 5818.468965999804, 5854.707264636836, 5871.295444546511, 5508.813301890672, 5542.533572560172, 5553.972230138824, 5625.606207565431, 5626.184203290418, 5603.0, 5623.268975033219, 5625.437456254342, 5639.746211420578, 5643.435656434323, 4528.6377089833395, 4862.565543164704, 4977.0, 5037.420696619935, 5486.945130548644, 4952.430470495795, 5153.521373073236, 5604.411536788579, 5611.80358687444, 5621.971890140687, 4800.471948085638, 5405.702686352131, 5460.259722090381, 5468.371137319259, 5494.423085576117], "value": 4080.357199055837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.827721346877, 755.964328869449, 781.3866115099647, 787.3976408047845, 797.7487091566156, 13696.246706431142, 14126.717465650694, 14354.856451435482, 14901.180435076067, 15697.21513924305, 14166.504172353969, 14215.289235538208, 14308.0, 14474.782878256809, 14502.129872207648, 839.290799274615, 861.5046348349692, 861.5606040919114, 861.8448679237766, 862.3316929379749, 693.944484441246, 712.8396110875063, 866.9263112635433, 870.3254977392539, 871.4379225399614, 746.779699988502, 886.9911300887005, 912.2929729459655, 919.2691810011024, 922.3912217936163, 884.1600479544459, 899.4827973915025, 904.2675432899373, 908.4004556992386, 909.3043821476575, 532.4489153725875, 669.2537820330346, 672.6199697171082, 672.8856094463904, 673.192169396726, 12374.505019799197, 14240.92879535606, 14734.410623575044, 14792.964492485531, 15066.54800355991, 10890.836637450444, 14310.427582896671, 14366.35351409189, 14431.783523247159, 14453.78319325211, 11087.83368249477, 11317.207795454322, 11388.71528211793, 11731.296122232694, 12275.631731047994, 3540.13041018667, 3695.1870588470492, 3770.0, 3847.576766555677, 3854.4411060396087, 99434.99999999927, 105196.47401762943, 108148.4592577032, 108490.0, 109287.45356273168, 10569.682909512727, 10607.41659208751, 10886.836697449544, 11009.0, 11308.151888608387, 22725.772742272366, 23174.1889033883, 23180.65229021566, 23212.41968950756, 23214.071437142662, 7387.1135463744695, 7394.593297368697, 7491.812704682427, 7497.362724168507, 7498.062742157231, 3840.30874442603, 4201.894952626148, 4261.275583150872, 4349.0, 4458.754768487699, 3535.275268569937, 3592.2815436912724, 3609.9639003609627, 3619.49327094207, 3642.417213245868, 609.5306613907355, 617.1051974636795, 618.1593033474471, 626.223482881233, 629.7921685843661, 573.6529399713197, 611.788932818177, 656.2617055812211, 661.147120214927, 662.4468568745152, 9277.721668349961, 9497.192738617296, 10139.138173255356, 10780.501129901351, 11025.669229923114, 565.1325215793819, 573.4466240078344, 592.7332700284803, 636.2651137935692, 694.7290556682898, 4355.346697995263, 4478.373027776114, 4941.851744447672, 4943.110240156806, 4953.6037117030555, 65184.0, 93535.0, 99064.0, 100037.49981250193, 103988.48005759923, 86153.70769438463, 89077.0, 90343.0, 92281.0, 93897.530512347, 74027.5194496107, 74469.88295175685, 74757.25242747612, 76887.0, 78202.21797782063, 9108.180263776292, 9506.47714375716, 9552.188064014637, 9555.569999349907, 9649.807003860024, 47459.0, 48153.27770083521, 50072.74963625159, 51428.22857657213, 52556.737216313675, 69802.60394792177, 70376.64811675908, 70751.64624176847, 72701.0, 74656.25343746493, 12265.152793354222, 12638.684032899251, 12749.553765618159, 12824.358782061046, 13367.930565554927, 13654.863451365756, 14302.031532901954, 14454.855451445772, 14512.637184070483, 15043.6991260172, 12401.75196496047, 12688.87311126877, 13473.124246923919, 13742.381592828147, 13755.79366309526, 12340.321282329558, 13355.230417039758, 13360.860351664338, 13505.527306544223, 13701.862981370059, 13005.154664946747, 13048.086633935533, 13061.673458163621, 13183.53857614979, 13698.794518082435, 10254.846177307496, 11056.557737690402, 11143.849467601307, 11148.554057837595, 11382.317060976367, 9238.538073096184, 9359.743617902775, 9545.120765276846, 10776.730581735519, 10785.514651840529], "value": 7365.84395322241, "unit": "score"}], "name": "dromaeo_css", "value": 7300.774981079601, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 164.0, 171.0, 115.0, 116.0, 115.0, 116.0, 115.0, 114.0, 115.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 95.0, 110.0, 143.0, 108.0, 111.0, 110.0, 109.0, 133.0, 139.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 181.0, 188.0, 184.0, 184.0, 185.0, 186.0, 182.0, 186.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 90.0, 61.0, 59.0, 58.0, 60.0, 73.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 70.0, 67.0, 69.0, 104.0, 98.0, 79.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 91.0, 88.0, 91.0, 88.0, 91.0, 87.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 99.0, 100.0, 100.0, 100.0, 101.0, 101.0, 100.0, 101.0, 101.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 106.0, 114.0, 87.0, 87.0, 88.0, 85.0, 86.0, 101.0, 133.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 52.0, 55.0, 56.0, 57.0, 55.0, 56.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 73.0, 75.0, 72.0, 67.0, 71.0, 69.0, 68.0, 68.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 84.0, 86.0, 83.0, 83.0, 87.0, 88.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 145.0, 138.0, 137.0, 137.0, 146.0, 154.0, 156.0, 177.0, 137.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 170.0, 177.0, 232.0, 149.0, 207.0, 236.0, 217.0, 169.0], "value": 190.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 64.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1479.6999999999998, "alertThreshold": 2.0}]} 09:14:38 INFO - Return code: 0 09:14:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:38 ERROR - # TBPL SUCCESS # 09:14:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:38 INFO - 2017-02-22 09:14:38.153 screenresolution[1652:9802] starting screenresolution argv=screenresolution get 09:14:38 INFO - 2017-02-22 09:14:38.157 screenresolution[1652:9802] Display 0: 1600x1200x32@60 09:14:38 INFO - 2017-02-22 09:14:38.163 screenresolution[1653:9805] starting screenresolution argv=screenresolution list 09:14:38 INFO - Available Modes on Display 0 09:14:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:38 INFO - Intel Iris: 09:14:38 INFO - Chipset Model: Intel Iris 09:14:38 INFO - Type: GPU 09:14:38 INFO - Bus: Built-In 09:14:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:38 INFO - Vendor: Intel (0x8086) 09:14:38 INFO - Device ID: 0x0a2e 09:14:38 INFO - Revision ID: 0x0009 09:14:38 INFO - Displays: 09:14:38 INFO - Display: 09:14:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:38 INFO - Display Serial Number: 1600x1200 60 09:14:38 INFO - Main Display: Yes 09:14:38 INFO - Mirror: Off 09:14:38 INFO - Online: Yes 09:14:38 INFO - Rotation: Supported 09:14:38 INFO - Return code: 0 09:14:38 INFO - Running post-action listener: _resource_record_post_action 09:14:38 INFO - [mozharness: 2017-02-22 17:14:38.402133Z] Finished run-tests step (success) 09:14:38 INFO - Running post-run listener: _resource_record_post_run 09:14:38 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 37815296; Write bytes: 505262080; Read time: 237; Write time: 1568 09:14:38 INFO - TinderboxPrint: CPU usage
53.6% 09:14:38 INFO - TinderboxPrint: I/O read bytes / time
37,815,296 / 237 09:14:38 INFO - TinderboxPrint: I/O write bytes / time
505,262,080 / 1,568 09:14:38 INFO - TinderboxPrint: CPU idle
2,226.1 (46.4%) 09:14:38 INFO - TinderboxPrint: CPU system
958.8 (20.0%) 09:14:38 INFO - TinderboxPrint: CPU user
1,616.8 (33.7%) 09:14:38 INFO - TinderboxPrint: Swap in / out
245,538,816 / 0 09:14:38 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200335872; Write bytes: 200542208; Read time: 15432; Write time: 445 09:14:38 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36889600; Write bytes: 294893568; Read time: 224; Write time: 1094 09:14:38 INFO - Running post-run listener: _upload_blobber_files 09:14:38 INFO - Blob upload gear active. 09:14:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:14:38 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:38 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:40 INFO - (blobuploader) - INFO - Done attempting. 09:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:41 INFO - (blobuploader) - INFO - Done attempting. 09:14:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:14:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:42 INFO - (blobuploader) - INFO - Done attempting. 09:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:45 INFO - (blobuploader) - INFO - Done attempting. 09:14:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:45 INFO - Return code: 0 09:14:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14ecb43e523ea3a636465445622961ddd7cba21cde08df0eacd5d854888c2084e464f23cbd36cd8eb908d0f1dc20fca96d89cc6bd36b9cbf1696fe86b7264da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4529699129fd71fa972fa89fa74f4b8f94530f0b3c9d89780e866a7df6b4a38cd077ee724bc4f508b833afa20ab108e2bdbdf9972909bff7c11416bbc004c1c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239fcdcb8e642deb5498a3dd83eb861d8e463887c2591cd237f63d21df1d348e916d343dc12c1175bfcd11550a28c47df204cf7460fd2846d3bb3b7b39caec14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58812ee39191d283319e3ef4fe3abbc8a97539e102efc88b14ba4081f19519fc8bdb39d43e7d8d00c950c8105ea1b1426513c38d4eba1b31f5b7b24399157e5c"} 09:14:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:45 INFO - Contents: 09:14:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14ecb43e523ea3a636465445622961ddd7cba21cde08df0eacd5d854888c2084e464f23cbd36cd8eb908d0f1dc20fca96d89cc6bd36b9cbf1696fe86b7264da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4529699129fd71fa972fa89fa74f4b8f94530f0b3c9d89780e866a7df6b4a38cd077ee724bc4f508b833afa20ab108e2bdbdf9972909bff7c11416bbc004c1c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239fcdcb8e642deb5498a3dd83eb861d8e463887c2591cd237f63d21df1d348e916d343dc12c1175bfcd11550a28c47df204cf7460fd2846d3bb3b7b39caec14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58812ee39191d283319e3ef4fe3abbc8a97539e102efc88b14ba4081f19519fc8bdb39d43e7d8d00c950c8105ea1b1426513c38d4eba1b31f5b7b24399157e5c"} 09:14:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:45 INFO - Copying logs to upload dir... 09:14:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.722929 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-22 09:14:45.394078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 09:14:45.397756) ========= 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.mAQKJJzBai/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.k3plXjwhDF/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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/Mozilla-Aurora/sha512/b14ecb43e523ea3a636465445622961ddd7cba21cde08df0eacd5d854888c2084e464f23cbd36cd8eb908d0f1dc20fca96d89cc6bd36b9cbf1696fe86b7264da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4529699129fd71fa972fa89fa74f4b8f94530f0b3c9d89780e866a7df6b4a38cd077ee724bc4f508b833afa20ab108e2bdbdf9972909bff7c11416bbc004c1c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239fcdcb8e642deb5498a3dd83eb861d8e463887c2591cd237f63d21df1d348e916d343dc12c1175bfcd11550a28c47df204cf7460fd2846d3bb3b7b39caec14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58812ee39191d283319e3ef4fe3abbc8a97539e102efc88b14ba4081f19519fc8bdb39d43e7d8d00c950c8105ea1b1426513c38d4eba1b31f5b7b24399157e5c"} build_url:https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/DXO3WVS7REaOjqlfvGJ-vA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14ecb43e523ea3a636465445622961ddd7cba21cde08df0eacd5d854888c2084e464f23cbd36cd8eb908d0f1dc20fca96d89cc6bd36b9cbf1696fe86b7264da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4529699129fd71fa972fa89fa74f4b8f94530f0b3c9d89780e866a7df6b4a38cd077ee724bc4f508b833afa20ab108e2bdbdf9972909bff7c11416bbc004c1c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239fcdcb8e642deb5498a3dd83eb861d8e463887c2591cd237f63d21df1d348e916d343dc12c1175bfcd11550a28c47df204cf7460fd2846d3bb3b7b39caec14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58812ee39191d283319e3ef4fe3abbc8a97539e102efc88b14ba4081f19519fc8bdb39d43e7d8d00c950c8105ea1b1426513c38d4eba1b31f5b7b24399157e5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 09:14:45.429692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:14:45.430033) ========= 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.mAQKJJzBai/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.k3plXjwhDF/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.004996 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:14:45.478324) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 09:14:45.478663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 09:14:45.479008) ========= ========= Total master_lag: 0.17 =========