builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0107 starttime: 1478949070.52 results: success (0) buildid: 20161112004002 builduid: 53b893d91b5d4ddba756de63dc7836a4 revision: 3d380055aaedfda2da14f5aee37eda8079105387 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:10.518865) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:10.528890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:10.529231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:10.555473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:10.555942) ========= 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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 --2016-11-12 03:11:10-- 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% 25.3M=0s 2016-11-12 03:11:11 (25.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.591621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:11.170578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:11.170887) ========= 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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.026907 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:11.219820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-12 03:11:11.220192) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3d380055aaedfda2da14f5aee37eda8079105387 --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 3d380055aaedfda2da14f5aee37eda8079105387 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 2016-11-12 03:11:11,295 truncating revision to first 12 chars 2016-11-12 03:11:11,295 Setting DEBUG logging. 2016-11-12 03:11:11,295 attempt 1/10 2016-11-12 03:11:11,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3d380055aaed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-12 03:11:12,502 unpacking tar archive at: mozilla-aurora-3d380055aaed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462126 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-12 03:11:12.706760) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:12.707052) ========= script_repo_revision: 3d380055aaedfda2da14f5aee37eda8079105387 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:12.707986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:12.708259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 03:11:12.727038) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-12 03:11:12.727465) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:12 INFO - MultiFileLogger online at 20161112 03:11:12 in /builds/slave/test 03:11:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:11:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:12 INFO - {'append_to_log': False, 03:11:12 INFO - 'base_work_dir': '/builds/slave/test', 03:11:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:11:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:12 INFO - 'branch': 'Mozilla-Aurora', 03:11:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:12 INFO - 'config_files': ('talos/mac_config.py',), 03:11:12 INFO - 'default_actions': ('clobber', 03:11:12 INFO - 'read-buildbot-config', 03:11:12 INFO - 'download-and-extract', 03:11:12 INFO - 'populate-webroot', 03:11:12 INFO - 'create-virtualenv', 03:11:12 INFO - 'install', 03:11:12 INFO - 'run-tests'), 03:11:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:12 INFO - 'download_minidump_stackwalk': True, 03:11:12 INFO - 'download_symbols': 'ondemand', 03:11:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:12 INFO - 'installer_path': 'installer.exe', 03:11:12 INFO - 'log_level': 'info', 03:11:12 INFO - 'log_name': 'talos', 03:11:12 INFO - 'log_to_console': True, 03:11:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:11:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:11:12 INFO - 'opt_config_files': (), 03:11:12 INFO - 'pip_index': False, 03:11:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:11:12 INFO - 'cmd': ('bash', 03:11:12 INFO - '-c', 03:11:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:11:12 INFO - 'enabled': True, 03:11:12 INFO - 'halt_on_failure': False, 03:11:12 INFO - 'name': 'check_screen_resolution'},), 03:11:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:11:12 INFO - 'cmd': ('bash', 03:11:12 INFO - '-c', 03:11:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:11:12 INFO - 'enabled': True, 03:11:12 INFO - 'halt_on_failure': False, 03:11:12 INFO - 'name': 'check_screen_resolution'},), 03:11:12 INFO - 'run_cmd_checks_enabled': True, 03:11:12 INFO - 'sps_profile': False, 03:11:12 INFO - 'sps_profile_interval': 0, 03:11:12 INFO - 'suite': 'dromaeojs-e10s', 03:11:12 INFO - 'system_bits': '32', 03:11:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:12 INFO - 'title': 't-yosemite-r7-0107', 03:11:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:12 INFO - 'use_talos_json': True, 03:11:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:12 INFO - 'work_dir': 'build'} 03:11:12 INFO - [mozharness: 2016-11-12 11:11:12.925031Z] Running clobber step. 03:11:12 INFO - Running pre-action listener: _resource_record_pre_action 03:11:12 INFO - Running main action method: clobber 03:11:12 INFO - rmtree: /builds/slave/test/build 03:11:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:15 INFO - Running post-action listener: _resource_record_post_action 03:11:15 INFO - [mozharness: 2016-11-12 11:11:15.303935Z] Finished clobber step (success) 03:11:15 INFO - [mozharness: 2016-11-12 11:11:15.304127Z] Running read-buildbot-config step. 03:11:15 INFO - Running pre-action listener: _resource_record_pre_action 03:11:15 INFO - Running main action method: read_buildbot_config 03:11:15 INFO - Using buildbot properties: 03:11:15 INFO - { 03:11:15 INFO - "project": "", 03:11:15 INFO - "product": "firefox", 03:11:15 INFO - "script_repo_revision": "production", 03:11:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:11:15 INFO - "repository": "", 03:11:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:11:15 INFO - "buildid": "20161112004002", 03:11:15 INFO - "stage_platform": "macosx64", 03:11:15 INFO - "basedir": "/builds/slave/test", 03:11:15 INFO - "nightly_build": "True", 03:11:15 INFO - "buildnumber": 17, 03:11:15 INFO - "slavename": "t-yosemite-r7-0107", 03:11:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:11:15 INFO - "platform": "yosemite_r7", 03:11:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:11:15 INFO - "branch": "mozilla-aurora", 03:11:15 INFO - "repo_path": "releases/mozilla-aurora", 03:11:15 INFO - "revision": "3d380055aaedfda2da14f5aee37eda8079105387", 03:11:15 INFO - "pgo_build": "False", 03:11:15 INFO - "builduid": "53b893d91b5d4ddba756de63dc7836a4", 03:11:15 INFO - "slavebuilddir": "test" 03:11:15 INFO - } 03:11:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:11:15 INFO - Running post-action listener: _resource_record_post_action 03:11:15 INFO - [mozharness: 2016-11-12 11:11:15.309643Z] Finished read-buildbot-config step (success) 03:11:15 INFO - [mozharness: 2016-11-12 11:11:15.309863Z] Running download-and-extract step. 03:11:15 INFO - Running pre-action listener: _resource_record_pre_action 03:11:15 INFO - Running main action method: download_and_extract 03:11:15 INFO - mkdir: /builds/slave/test/build/tests 03:11:15 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')]} 03:11:15 INFO - trying https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:11:15 INFO - Downloading https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:11:16 INFO - Downloaded 1199 bytes. 03:11:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:11:16 INFO - Using the following test package requirements: 03:11:16 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:11:16 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:11:16 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:11:16 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'jsshell-mac.zip'], 03:11:16 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:11:16 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:11:16 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:11:16 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:11:16 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:11:16 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:16 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:11:16 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:11:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:11:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:11:16 INFO - Fetch https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:11:17 INFO - Expected file size: 16423967 03:11:24 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:11:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:11:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:11:24 INFO - Fetch https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:11:25 INFO - Expected file size: 16423967 03:11:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:11:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:11:32 INFO - Fetch https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:11:32 INFO - Expected file size: 14414089 03:11:33 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')]} 03:11:33 INFO - trying https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:11:33 INFO - Downloading https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:11:36 INFO - Downloaded 115631299 bytes. 03:11:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:11:36 INFO - mkdir: /builds/slave/test/properties 03:11:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:36 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:36 INFO - Contents: 03:11:36 INFO - build_url:https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:11:36 INFO - Running post-action listener: _resource_record_post_action 03:11:36 INFO - Running post-action listener: set_extra_try_arguments 03:11:36 INFO - [mozharness: 2016-11-12 11:11:36.880860Z] Finished download-and-extract step (success) 03:11:36 INFO - [mozharness: 2016-11-12 11:11:36.880982Z] Running populate-webroot step. 03:11:36 INFO - Running pre-action listener: _resource_record_pre_action 03:11:36 INFO - Running main action method: populate_webroot 03:11:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:36 INFO - '--tppagecycles', 03:11:36 INFO - '7'], 03:11:36 INFO - 'tests': ['tsvgm']}}, 03:11:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['damp', 'tps']}, 03:11:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'tests': ['damp', 'tps']}, 03:11:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['dromaeo_dom']}, 03:11:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['basic_compositor_video']}, 03:11:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:11:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['a11yr', 03:11:36 INFO - 'ts_paint', 03:11:36 INFO - 'tpaint', 03:11:36 INFO - 'sessionrestore', 03:11:36 INFO - 'sessionrestore_no_auto_restore', 03:11:36 INFO - 'tabpaint']}, 03:11:36 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:36 INFO - 'ts_paint', 03:11:36 INFO - 'tpaint', 03:11:36 INFO - 'sessionrestore', 03:11:36 INFO - 'sessionrestore_no_auto_restore', 03:11:36 INFO - 'tabpaint']}, 03:11:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:11:36 INFO - 'ts_paint', 03:11:36 INFO - 'tpaint', 03:11:36 INFO - 'sessionrestore', 03:11:36 INFO - 'sessionrestore_no_auto_restore', 03:11:36 INFO - 'tabpaint']}, 03:11:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:11:36 INFO - 'ts_paint', 03:11:36 INFO - 'tpaint', 03:11:36 INFO - 'sessionrestore', 03:11:36 INFO - 'sessionrestore_no_auto_restore', 03:11:36 INFO - 'tabpaint']}, 03:11:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['a11yr', 03:11:36 INFO - 'ts_paint', 03:11:36 INFO - 'tpaint', 03:11:36 INFO - 'sessionrestore', 03:11:36 INFO - 'sessionrestore_no_auto_restore', 03:11:36 INFO - 'tabpaint']}, 03:11:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['a11yr', 03:11:36 INFO - 'ts_paint', 03:11:36 INFO - 'tpaint', 03:11:36 INFO - 'sessionrestore', 03:11:36 INFO - 'sessionrestore_no_auto_restore', 03:11:36 INFO - 'tabpaint']}, 03:11:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['tsvgx', 03:11:36 INFO - 'tsvgr_opacity', 03:11:36 INFO - 'tart', 03:11:36 INFO - 'tscrollx', 03:11:36 INFO - 'cart']}, 03:11:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:36 INFO - 'tsvgr_opacity', 03:11:36 INFO - 'tart', 03:11:36 INFO - 'tscrollx', 03:11:36 INFO - 'cart']}, 03:11:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'talos_options': ['--disable-e10s'], 03:11:36 INFO - 'tests': ['tp5o']}, 03:11:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'tests': ['tp5o']}, 03:11:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'talos_options': ['--disable-e10s', 03:11:36 INFO - '--xperf_path', 03:11:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:36 INFO - 'tests': ['tp5n']}, 03:11:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:36 INFO - 'talos_options': ['--xperf_path', 03:11:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:36 INFO - 'tests': ['tp5n']}}, 03:11:36 INFO - 'talos.zip': {'path': '', 03:11:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:36 INFO - Running post-action listener: _resource_record_post_action 03:11:36 INFO - [mozharness: 2016-11-12 11:11:36.899485Z] Finished populate-webroot step (success) 03:11:36 INFO - [mozharness: 2016-11-12 11:11:36.899615Z] Running create-virtualenv step. 03:11:36 INFO - Running pre-action listener: _resource_record_pre_action 03:11:36 INFO - Running main action method: create_virtualenv 03:11:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:36 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 03:11:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:37 INFO - Using real prefix '/tools/python27' 03:11:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:40 INFO - Installing pip.................done. 03:11:40 INFO - Return code: 0 03:11:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:40 INFO - 'HOME': '/Users/cltbld', 03:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:40 INFO - 'LOGNAME': 'cltbld', 03:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:40 INFO - 'MOZ_NO_REMOTE': '1', 03:11:40 INFO - 'NO_EM_RESTART': '1', 03:11:40 INFO - 'PAGER': '/bin/cat', 03:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:40 INFO - 'PWD': '/builds/slave/test', 03:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:40 INFO - 'SHELL': '/bin/bash', 03:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:11:40 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:40 INFO - 'USER': 'cltbld', 03:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:40 INFO - 'XPC_FLAGS': '0x0', 03:11:40 INFO - 'XPC_SERVICE_NAME': '0', 03:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:40 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 03:11:40 INFO - Cleaning up... 03:11:40 INFO - Return code: 0 03:11:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:40 INFO - 'HOME': '/Users/cltbld', 03:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:40 INFO - 'LOGNAME': 'cltbld', 03:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:40 INFO - 'MOZ_NO_REMOTE': '1', 03:11:40 INFO - 'NO_EM_RESTART': '1', 03:11:40 INFO - 'PAGER': '/bin/cat', 03:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:40 INFO - 'PWD': '/builds/slave/test', 03:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:40 INFO - 'SHELL': '/bin/bash', 03:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:11:40 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:40 INFO - 'USER': 'cltbld', 03:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:40 INFO - 'XPC_FLAGS': '0x0', 03:11:40 INFO - 'XPC_SERVICE_NAME': '0', 03:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:41 INFO - Downloading/unpacking psutil>=3.1.1 03:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:44 INFO - Installing collected packages: psutil 03:11:44 INFO - Running setup.py install for psutil 03:11:45 INFO - building 'psutil._psutil_osx' extension 03:11:45 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 03:11:45 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 03:11:45 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 03:11:45 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 03:11:45 INFO - building 'psutil._psutil_posix' extension 03:11:45 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 03:11:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:11:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:11:45 INFO - ^ 03:11:46 INFO - 1 warning generated. 03:11:46 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 03:11:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:46 INFO - Successfully installed psutil 03:11:46 INFO - Cleaning up... 03:11:46 INFO - Return code: 0 03:11:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:46 INFO - 'HOME': '/Users/cltbld', 03:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:46 INFO - 'LOGNAME': 'cltbld', 03:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:46 INFO - 'MOZ_NO_REMOTE': '1', 03:11:46 INFO - 'NO_EM_RESTART': '1', 03:11:46 INFO - 'PAGER': '/bin/cat', 03:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:46 INFO - 'PWD': '/builds/slave/test', 03:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:46 INFO - 'SHELL': '/bin/bash', 03:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:11:46 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:46 INFO - 'USER': 'cltbld', 03:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:46 INFO - 'XPC_FLAGS': '0x0', 03:11:46 INFO - 'XPC_SERVICE_NAME': '0', 03:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:11:49 INFO - Installing collected packages: mozsystemmonitor 03:11:49 INFO - Running setup.py install for mozsystemmonitor 03:11:49 INFO - Successfully installed mozsystemmonitor 03:11:49 INFO - Cleaning up... 03:11:49 INFO - Return code: 0 03:11:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:11:49 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')]} 03:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 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')]} 03:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:49 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 03:11:49 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 03:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:49 INFO - 'HOME': '/Users/cltbld', 03:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:49 INFO - 'LOGNAME': 'cltbld', 03:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:49 INFO - 'MOZ_NO_REMOTE': '1', 03:11:49 INFO - 'NO_EM_RESTART': '1', 03:11:49 INFO - 'PAGER': '/bin/cat', 03:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:49 INFO - 'PWD': '/builds/slave/test', 03:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:49 INFO - 'SHELL': '/bin/bash', 03:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:11:49 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:49 INFO - 'USER': 'cltbld', 03:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:49 INFO - 'XPC_FLAGS': '0x0', 03:11:49 INFO - 'XPC_SERVICE_NAME': '0', 03:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:11:52 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 03:11:52 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 03:11:52 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 03:11:52 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 03:11:52 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 03:11:52 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 03:11:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:52 INFO - warning: no files found matching '*.txt' 03:11:52 INFO - no previously-included directories found matching 'build' 03:11:52 INFO - no previously-included directories found matching 'dist' 03:11:52 INFO - no previously-included directories found matching '.git*' 03:11:52 INFO - Installing collected packages: jsonschema, functools32 03:11:52 INFO - Running setup.py install for functools32 03:11:52 INFO - warning: no files found matching '*.txt' 03:11:52 INFO - no previously-included directories found matching 'build' 03:11:52 INFO - no previously-included directories found matching 'dist' 03:11:52 INFO - no previously-included directories found matching '.git*' 03:11:52 INFO - Successfully installed jsonschema functools32 03:11:52 INFO - Cleaning up... 03:11:52 INFO - Return code: 0 03:11:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:11:52 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')]} 03:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:52 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')]} 03:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:52 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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:52 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 03:11:52 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 03:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:52 INFO - 'HOME': '/Users/cltbld', 03:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:52 INFO - 'LOGNAME': 'cltbld', 03:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:52 INFO - 'MOZ_NO_REMOTE': '1', 03:11:52 INFO - 'NO_EM_RESTART': '1', 03:11:52 INFO - 'PAGER': '/bin/cat', 03:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:52 INFO - 'PWD': '/builds/slave/test', 03:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:52 INFO - 'SHELL': '/bin/bash', 03:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:11:52 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:52 INFO - 'USER': 'cltbld', 03:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:52 INFO - 'XPC_FLAGS': '0x0', 03:11:52 INFO - 'XPC_SERVICE_NAME': '0', 03:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:11:53 INFO - Cleaning up... 03:11:53 INFO - Return code: 0 03:11:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:53 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 03:11:53 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 03:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:53 INFO - 'HOME': '/Users/cltbld', 03:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:53 INFO - 'LOGNAME': 'cltbld', 03:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:53 INFO - 'MOZ_NO_REMOTE': '1', 03:11:53 INFO - 'NO_EM_RESTART': '1', 03:11:53 INFO - 'PAGER': '/bin/cat', 03:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:53 INFO - 'PWD': '/builds/slave/test', 03:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:53 INFO - 'SHELL': '/bin/bash', 03:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:11:53 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:53 INFO - 'USER': 'cltbld', 03:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:53 INFO - 'XPC_FLAGS': '0x0', 03:11:53 INFO - 'XPC_SERVICE_NAME': '0', 03:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:53 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 03:11:53 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 03:11:53 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 03:11:53 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 03:11:53 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 03:11:53 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 03:11:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:56 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 03:11:56 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 03:11:56 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 03:11:56 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 03:11:56 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 03:11:56 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 03:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:56 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 03:11:56 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 03:11:56 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 03:11:56 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 03:11:56 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 03:11:56 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 03:11:57 INFO - Downloading docopt-0.6.1.tar.gz 03:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:57 INFO - Running setup.py install for blobuploader 03:11:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:57 INFO - Running setup.py install for requests 03:11:57 INFO - Running setup.py install for docopt 03:11:58 INFO - Successfully installed blobuploader requests docopt 03:11:58 INFO - Cleaning up... 03:11:58 INFO - Return code: 0 03:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:58 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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:11:58 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 03:11:58 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 03:11:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:11:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:58 INFO - 'HOME': '/Users/cltbld', 03:11:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:58 INFO - 'LOGNAME': 'cltbld', 03:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:58 INFO - 'MOZ_NO_REMOTE': '1', 03:11:58 INFO - 'NO_EM_RESTART': '1', 03:11:58 INFO - 'PAGER': '/bin/cat', 03:11:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:58 INFO - 'PWD': '/builds/slave/test', 03:11:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:58 INFO - 'SHELL': '/bin/bash', 03:11:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:11:58 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:11:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:58 INFO - 'USER': 'cltbld', 03:11:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:58 INFO - 'XPC_FLAGS': '0x0', 03:11:58 INFO - 'XPC_SERVICE_NAME': '0', 03:11:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:58 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-J7zrb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:58 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-9KS0rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:58 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-qM9UYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:58 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-hjKVdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:58 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-N7nNvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:58 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-24jF_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Z2e_KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-x7Zoop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-VCmwEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-o1A6pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-6qtjkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-KwZ8RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-64a6_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-X5KQdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-mnj3zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-cvPTNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:00 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-e_FRNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:12:00 INFO - Running setup.py install for manifestparser 03:12:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:12:00 INFO - Running setup.py install for mozcrash 03:12:00 INFO - Running setup.py install for mozdebug 03:12:00 INFO - Running setup.py install for mozdevice 03:12:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:12:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:12:00 INFO - Running setup.py install for mozfile 03:12:00 INFO - Running setup.py install for mozhttpd 03:12:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozinfo 03:12:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozInstall 03:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozleak 03:12:01 INFO - Running setup.py install for mozlog 03:12:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for moznetwork 03:12:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozprocess 03:12:01 INFO - Running setup.py install for mozprofile 03:12:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:12:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:12:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:12:02 INFO - Running setup.py install for mozrunner 03:12:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:12:02 INFO - Running setup.py install for mozscreenshot 03:12:02 INFO - Running setup.py install for moztest 03:12:02 INFO - Running setup.py install for mozversion 03:12:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:12:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:12:02 INFO - Cleaning up... 03:12:02 INFO - Return code: 0 03:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:02 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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:12:02 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 03:12:02 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 03:12:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:12:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:02 INFO - 'HOME': '/Users/cltbld', 03:12:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:02 INFO - 'LOGNAME': 'cltbld', 03:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:02 INFO - 'MOZ_NO_REMOTE': '1', 03:12:02 INFO - 'NO_EM_RESTART': '1', 03:12:02 INFO - 'PAGER': '/bin/cat', 03:12:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:02 INFO - 'PWD': '/builds/slave/test', 03:12:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:02 INFO - 'SHELL': '/bin/bash', 03:12:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:12:02 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:12:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:02 INFO - 'USER': 'cltbld', 03:12:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:02 INFO - 'XPC_FLAGS': '0x0', 03:12:02 INFO - 'XPC_SERVICE_NAME': '0', 03:12:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-gCEr2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Dyc4lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ZiPKgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Absg67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-6k2OUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-063Jld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-BAB_ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-wg1got-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-cY4StH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-unORD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:04 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)) 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-AB86F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:04 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)) 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-VTbqRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-q9IFmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:04 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)) 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ARm_9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Fror_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:04 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)) 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-wQCRlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-XZY1ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:04 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)) 03:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:04 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)) 03:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:04 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 03:12:04 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 03:12:04 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 03:12:04 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 03:12:04 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 03:12:04 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 03:12:07 INFO - Downloading blessings-1.6.tar.gz 03:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:12:07 INFO - Installing collected packages: blessings 03:12:07 INFO - Running setup.py install for blessings 03:12:07 INFO - Successfully installed blessings 03:12:07 INFO - Cleaning up... 03:12:07 INFO - Return code: 0 03:12:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:08 INFO - Reading from file tmpfile_stdout 03:12:08 INFO - Current package versions: 03:12:08 INFO - blessings == 1.6 03:12:08 INFO - blobuploader == 1.2.4 03:12:08 INFO - docopt == 0.6.1 03:12:08 INFO - functools32 == 3.2.3-2 03:12:08 INFO - jsonschema == 2.5.1 03:12:08 INFO - manifestparser == 1.1 03:12:08 INFO - mozInstall == 1.12 03:12:08 INFO - mozcrash == 0.17 03:12:08 INFO - mozdebug == 0.1 03:12:08 INFO - mozdevice == 0.48 03:12:08 INFO - mozfile == 1.2 03:12:08 INFO - mozhttpd == 0.7 03:12:08 INFO - mozinfo == 0.9 03:12:08 INFO - mozleak == 0.1 03:12:08 INFO - mozlog == 3.4 03:12:08 INFO - moznetwork == 0.27 03:12:08 INFO - mozprocess == 0.23 03:12:08 INFO - mozprofile == 0.28 03:12:08 INFO - mozrunner == 6.12 03:12:08 INFO - mozscreenshot == 0.1 03:12:08 INFO - mozsystemmonitor == 0.3 03:12:08 INFO - moztest == 0.7 03:12:08 INFO - mozversion == 1.4 03:12:08 INFO - psutil == 3.1.1 03:12:08 INFO - requests == 1.2.3 03:12:08 INFO - wsgiref == 0.1.2 03:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:08 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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:12:08 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 03:12:08 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 03:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:08 INFO - 'HOME': '/Users/cltbld', 03:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:08 INFO - 'LOGNAME': 'cltbld', 03:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:08 INFO - 'MOZ_NO_REMOTE': '1', 03:12:08 INFO - 'NO_EM_RESTART': '1', 03:12:08 INFO - 'PAGER': '/bin/cat', 03:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:08 INFO - 'PWD': '/builds/slave/test', 03:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:08 INFO - 'SHELL': '/bin/bash', 03:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:12:08 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:08 INFO - 'USER': 'cltbld', 03:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:08 INFO - 'XPC_FLAGS': '0x0', 03:12:08 INFO - 'XPC_SERVICE_NAME': '0', 03:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 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)) 03:12:08 INFO - Cleaning up... 03:12:08 INFO - Return code: 0 03:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:08 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 0x105446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe49db5a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, '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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 03:12:08 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 03:12:08 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 03:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:08 INFO - 'HOME': '/Users/cltbld', 03:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:08 INFO - 'LOGNAME': 'cltbld', 03:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:08 INFO - 'MOZ_NO_REMOTE': '1', 03:12:08 INFO - 'NO_EM_RESTART': '1', 03:12:08 INFO - 'PAGER': '/bin/cat', 03:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:08 INFO - 'PWD': '/builds/slave/test', 03:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:08 INFO - 'SHELL': '/bin/bash', 03:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:12:08 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:08 INFO - 'USER': 'cltbld', 03:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:08 INFO - 'XPC_FLAGS': '0x0', 03:12:08 INFO - 'XPC_SERVICE_NAME': '0', 03:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:12:08 INFO - Cleaning up... 03:12:08 INFO - Return code: 0 03:12:08 INFO - Running post-action listener: _resource_record_post_action 03:12:08 INFO - Running post-action listener: _start_resource_monitoring 03:12:08 INFO - Starting resource monitoring. 03:12:08 INFO - [mozharness: 2016-11-12 11:12:08.575901Z] Finished create-virtualenv step (success) 03:12:08 INFO - [mozharness: 2016-11-12 11:12:08.576947Z] Running install step. 03:12:08 INFO - Running pre-action listener: _resource_record_pre_action 03:12:08 INFO - Running main action method: install 03:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:08 INFO - Reading from file tmpfile_stdout 03:12:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:12:08 INFO - Reading from file tmpfile_stdout 03:12:08 INFO - Output received: 03:12:08 INFO - Usage: mozinstall [options] installer 03:12:08 INFO - Options: 03:12:08 INFO - -h, --help show this help message and exit 03:12:08 INFO - -d DEST, --destination=DEST 03:12:08 INFO - Directory to install application into. [default: 03:12:08 INFO - "/builds/slave/test"] 03:12:08 INFO - --app=APP Application being installed. [default: firefox] 03:12:08 INFO - mkdir: /builds/slave/test/build/application 03:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:12:41 INFO - Reading from file tmpfile_stdout 03:12:41 INFO - Output received: 03:12:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:12:41 INFO - Running post-action listener: _resource_record_post_action 03:12:41 INFO - [mozharness: 2016-11-12 11:12:41.804512Z] Finished install step (success) 03:12:41 INFO - [mozharness: 2016-11-12 11:12:41.804641Z] Running run-tests step. 03:12:41 INFO - Running pre-action listener: _resource_record_pre_action 03:12:41 INFO - Running main action method: run_tests 03:12:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:12:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:12:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:12:41 INFO - 2016-11-12 03:12:41.819 screenresolution[1648:8613] starting screenresolution argv=screenresolution get 03:12:41 INFO - 2016-11-12 03:12:41.821 screenresolution[1648:8613] Display 0: 1600x1200x32@60 03:12:41 INFO - 2016-11-12 03:12:41.827 screenresolution[1649:8615] starting screenresolution argv=screenresolution list 03:12:41 INFO - Available Modes on Display 0 03:12:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:12:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:12:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:12:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:12:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:12:42 INFO - Intel Iris: 03:12:42 INFO - Chipset Model: Intel Iris 03:12:42 INFO - Type: GPU 03:12:42 INFO - Bus: Built-In 03:12:42 INFO - VRAM (Dynamic, Max): 1536 MB 03:12:42 INFO - Vendor: Intel (0x8086) 03:12:42 INFO - Device ID: 0x0a2e 03:12:42 INFO - Revision ID: 0x0009 03:12:42 INFO - Displays: 03:12:42 INFO - Display: 03:12:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:12:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:12:42 INFO - Display Serial Number: 1600x1200 60 03:12:42 INFO - Main Display: Yes 03:12:42 INFO - Mirror: Off 03:12:42 INFO - Online: Yes 03:12:42 INFO - Rotation: Supported 03:12:42 INFO - Return code: 0 03:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:42 INFO - Python 2.7.3 03:12:42 INFO - Return code: 0 03:12:42 INFO - grabbing minidump binary from tooltool 03:12:42 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')]} 03:12:42 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 0x10525ad30>, '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 0x1050c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105252b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:42 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 03:12:42 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 03:12:42 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 03:12:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:42 INFO - Return code: 0 03:12:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:12:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:12:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:12:42 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:12:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IrNlQZVEi0/Render', 03:12:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:42 INFO - 'HOME': '/Users/cltbld', 03:12:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:42 INFO - 'LOGNAME': 'cltbld', 03:12:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:42 INFO - 'MOZ_NO_REMOTE': '1', 03:12:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:42 INFO - 'NO_EM_RESTART': '1', 03:12:42 INFO - 'PAGER': '/bin/cat', 03:12:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:42 INFO - 'PWD': '/builds/slave/test', 03:12:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:42 INFO - 'SHELL': '/bin/bash', 03:12:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FQAZcTvyQ1/Listeners', 03:12:42 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 03:12:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:42 INFO - 'USER': 'cltbld', 03:12:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:42 INFO - 'XPC_FLAGS': '0x0', 03:12:42 INFO - 'XPC_SERVICE_NAME': '0', 03:12:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:12:42 INFO - mozversion application_buildid: 20161112004002 03:12:42 INFO - mozversion application_changeset: 3d380055aaedfda2da14f5aee37eda8079105387 03:12:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:12:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:42 INFO - mozversion application_name: Firefox 03:12:42 INFO - mozversion application_remotingname: firefox-dev 03:12:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:42 INFO - mozversion application_vendor: Mozilla 03:12:42 INFO - mozversion application_version: 51.0a2 03:12:42 INFO - mozversion platform_buildid: 20161112004002 03:12:42 INFO - mozversion platform_changeset: 3d380055aaedfda2da14f5aee37eda8079105387 03:12:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:42 INFO - mozversion platform_version: 51.0a2 03:12:42 INFO - using testdate: 1478949162 03:12:42 INFO - actual date: 1478949162 03:12:42 INFO - starting webserver on 'localhost:49267' 03:12:42 INFO - SUITE-START | Running 2 tests 03:12:42 INFO - TEST-START | dromaeo_css 03:12:42 INFO - operating with platform_type : mac_ 03:12:42 INFO - Initialising browser for dromaeo_css test... 03:12:42 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpQkXdQe/profile http://localhost:49267/getInfo.html) 03:12:45 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 03:12:45 INFO - PROCESS | 1659 | colorDepth:24 03:12:45 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 03:12:45 INFO - PROCESS | 1659 | __metrics 03:12:45 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:12:46 INFO - TEST-INFO | 1659: exit 0 03:12:46 INFO - Browser initialized. 03:12:46 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:46 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpQkXdQe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:58 INFO - PROCESS | 1664 | RSS: Main: 225902592 03:12:58 INFO - PROCESS | 1664 | 03:13:47 INFO - PROCESS | 1664 | 1478949227790 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:16:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 03:16:01 INFO - PROCESS | 1664 | RSS: Main: 237268992 03:16:01 INFO - PROCESS | 1664 | 03:19:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 03:19:04 INFO - PROCESS | 1664 | RSS: Main: 250638336 03:19:04 INFO - PROCESS | 1664 | 03:22:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 03:22:07 INFO - PROCESS | 1664 | RSS: Main: 252829696 03:22:07 INFO - PROCESS | 1664 | 03:25:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 03:25:09 INFO - PROCESS | 1664 | RSS: Main: 254406656 03:25:09 INFO - PROCESS | 1664 | 03:28:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 03:28:13 INFO - PROCESS | 1664 | RSS: Main: 258838528 03:28:13 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 03:31:16 INFO - PROCESS | 1664 | RSS: Main: 260702208 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | __start_tp_report 03:31:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 03:31:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 03:31:16 INFO - PROCESS | 1664 | |i|pagename|runs| 03:31:16 INFO - PROCESS | 1664 | |0;dojo.html;2884.3654396032894;3274.7216486598636;3312.188513814115;3487.982560087199;3492.1444246159695;5822.4177582241755;5834.912476312853;5861;5903.055511118217;5927.2590926134235;5811.186433899247;5888.941110588893;5923.407659234074;5936;5976.37248088952;5342.652727572715;5399.40606533283;5429.647072940246;5437.782488700447;5450.400455949843;5406.270153529263;5433.26650902129;5449.155380915964;5450.427705090968;5468.48049435303;5335.013022590813;5335.359756829166;5344.4922732340365;5380.192971054334;5481.5340696040885;4424.535423780505;5398.78404863805;5406.783728650849;5416.729163541847;5447.101228297326;5222.97388513055;5350.602947744514;5359.490848369399;5376.247325374412;5411.107167317427;5451.618386712892;5688.089905615082;5711.143328500717;5763.5101016413655;5840.766369345263;6207.751689932397;6224.066390041485;6233.470155036827;6293.433590976834;6325.936740632626;6316.968415157895;6345.49236061114;6358.173437453148;6362.236531616236;6376.202974628171;5867.559933004956;5894.0274854648505;5969.074793407029;5970.701464926737;5994.760209591567;6416.615003099829;6418.133551970424;6419.614823110535;6426.2931077581425;6481.967590162019;4506.932396014063;6227.346128656426;6237.688115594202;6310.5898116622275;6317.9684101580115;4689.95310046902;5061.468545802712;6236.563440559117;6243.375662433811;6266.780662676784;4613.031263434649;5759.94240057594;6089.939100608937;6274.560780745304;6326.905096423558;5704.573856535866;6087.604305720114;6313.905291420632;6342.302346741854;6342.904856427157;4555.954440455619;4797.664163508591;4949.1091603510995;4967.403911530567;5006.07387633289;3842.9231415371537;4477.7313361197785;4494.595486406239;4513.277875539898;4533.501314855429;5627.915581266284;5915.438033386821;5982.880342393128;6019.157317975487;6047.485963693048;6199.752009919553;6302.779402720883;6304.356498843058;6332.240131184288;6358.745650173942;4682.4381074271305;5973.1338955852025;6003.159557661931;6029.457348838538;6039.969800150971;5390.865228369244;5528.889422211533;5531.612787104945;5556.138798486241;5558.610897237155;6297.842553936188;6459.128017717548;6473.320301368382;6498.610083395011;6523.445507131947;6269.467095296951;6288.434040936338;6296.842578935563;6323.557350985387;6359.395857393541;6409.9679501602195;6476.643784591704;6480.967595161994;6489.221293444817;6493.253275873146;6260.530460215411;6290.21372328459;6309.432151106423;6342.9682851587295;6351.110844481868;6260.154879091265;6263.530235232467;6278.591891527036;6283.842903927439;6320.209973753281;4909.4845041270155;5684.8294551163535;5783.942160578508;6202.255729312511;6253.343398943045;6159.445649891352;6240.687965601793;6242.063690446469;6254.2807577129215;6258.186435763321;5928.081147422156;5936.22829032223;6043.09353596964;6094.8171554853425;6098.237720284965;6221.906671399842;6272.153259309935;6298.527610429144;6301.086342480223;6305.337939516468;6126.08108783686;6145.477634401126;6147.969260153671;6148.907766383419;6166.907496387468 03:31:16 INFO - PROCESS | 1664 | |1;ext.html;480.20765736534713;523.6151428699906;532.0529457565535;538.7279423890933;545.7816873250702;40713;42459.575404245945;42568.361474577905;42587.99999999996;42600;44082.55917440833;44454.55545444544;44699;44847.103057938824;44882.77558612211;9850.408975461478;9963.302568820185;10029.24780641451;10054.698359049204;10077.395356278646;9789.118979291863;9790.06994335537;9869.358491698053;9875.90124098757;9917.75205619858;9765.12113909748;9794.412335259907;9869.506524673774;9906.405615663047;9920.553575089138;9733.707988760349;9757.756056098584;9834.803303933917;9888.060634239771;9892.604295828158;9810.754731131707;9831.115199631997;9884.80230395388;9892.30753847231;9898.851517227247;42012.78993605043;42064;42185.578144218474;42446.363304550454;42506.937326566775;2690.757831795148;2780.374415756459;2839.4037252176863;3543.7519373643854;3545.2732189901267;28514.287142821388;31868.36263274745;31974;32238.516422253684;32257.51613725796;3036.9392612147853;3104.58088158098;3140.905772826819;3163.225009872573;3189.8883539076255;487533;492469;493317;497830;498360;50194;63017;63467;63702;65360;35242.118947026014;35666.82166589202;35954;66974;67378;14520.709585808225;17152.742708859376;17261.223244954006;17398.913005434893;17471.213795379237;13155.210687358598;13245.20528768277;13281.800772988412;13288.06983511145;13329.06696531253;16118.435854745028;19809.702854457195;19993.100310486065;19993.90033548169;20078.69881951772;7553.509021913558;8110.472819266847;8196.508209507449;8210.671573137008;8254.917450825535;883.8762573239752;910.4628269321;964.2334344196381;995.9990209839066;1108.490094556513;31936.520952185736;32478.83760581182;32726.509102363485;32755;32993.50509742356;1036.1917704190744;1064.4730858225228;1087.8205096159204;1105.8064838653204;1123.612353737959;14600.926995365167;16605.91697041507;16873.240704168096;17241.482755517103;17367.65264694699;656848;662666;665987;666083;669930;59692.104618430756;60150.398496015354;60176.66378392507;60238.39761602416;60255.69872150611;1167.5271515036593;1336.6457888659513;1350.540816122523;1383.578008707354;1385.3419625677723;25484;31573.210669733442;31786.682133178372;31923.36153276875;32967.50548741819;58159;58738.82522349615;58960;59065;59120;606800;609405;612762;621131;623014;43926.560734392246;44125;44716.882077948314;45076.09847803091;45087.774561126986;49590.50409495859;49634.75182624064;49643;49695.751521242164;50123.74938125286;40729.796351018056;40852.79573602113;41232.38151427671;41969.580304197785;42211.36682949697;37794;40742;40782.796086020564;41539.58460415357;42217;32994;38986.6101338983;39118.80440597779;39221;40137.996550085314;34514.82742586271;35830.82084589561;36127.45808812817;36243;36388;26506.734932650426;26639.60040599431;26664.06675766339;26707.06525271606;26977.595336070368 03:31:16 INFO - PROCESS | 1664 | |2;jquery.html;340.9079548521899;374.4028274901532;379.3891834147023;379.990500237494;386.6713293700353;19570.804291957076;19954.50113747157;20681.896590517044;20717.68923466149;20871;11480.196386252966;11890.46492907819;11894.64316070517;11898.821517677241;13099.803502947463;5242.659227150242;5489.368722596892;5518.448155184489;5521.2270282160525;5522.0336441122645;3916.9608303917025;4125.793710314488;4145.7719825409595;5426.131818908975;5948.167256584082;6209.316975132731;6604.636744979024;6847.417969472601;6928.515003949726;6934.202566704817;6106.8778624427705;6154.96922515389;6166.445019948226;6548.511565605063;6925.134358205224;5812.738426770806;5934.813037392496;5939.613925094855;5955.583109182316;5988.31134419543;22583.322500325015;23245.605263684232;25124.869380877903;25305.240842774747;27061;2038.8572799904014;2428.86641234732;2519.8740062996776;2530.9114181003574;2558.424354520218;13378.598642040753;16161;17014.659706805796;17576.91211543947;17706.20322085509;1893.8579606529427;1976.723258743777;1981.782003979561;2023.5345870449733;2036.7963203679512;115365.42317288443;115771.42114289459;117449;132079.33960330233;138853.3057334717;17027.574310642332;21438.678419823715;22218;22284.331470055924;22600.09599615997;35620.28759424797;35783.92648220558;36323.091922702144;36393;36457.54169833177;10124.645637402655;10994.34033957965;11048.226624136234;11282.041026512674;11752.88347606976;9161.404508706913;9290.396124251902;9291.349605527548;9307.720403147005;9458.95270523643;9954.104130628279;10118.696439106838;10122.88648248692;10136.783585969732;10156.136728378171;3867.5165604299464;3907.5115610548683;3963.365861462152;3970.285348637273;3974.741641793332;853.1894700034992;905.3300557587338;922.2207234886645;961.7499450143014;978.1099199728213;20180.798192018185;20609.690854637192;20817.1673133076;21231;21454;919.7148883846029;922.9492377919279;929.340168480373;970.679675707015;1023.3348323589578;10833.05005099074;11250.268732532359;11264.887351126548;11287.943560282147;11293.830592541119;556771;568723.1563842237;584116;591722;592806;107887;121098.39450802689;124949.37525312316;125798.99999999817;126950;944.5466176235445;952.8904176019569;970.403202030746;975.6780262513354;975.9853602195973;18515.35196268124;18813.811861881753;18877.622447550697;18900.905495472984;18981.43055708331;51318.97362052813;51543.48456515387;52944.4705552955;56226;57008.859822804145;78091;78263.60868195622;79595;79695.80456293044;79824;7130.750423735144;7260.528065675714;7629.618519074135;7953.443258971816;8349.624266908126;10428.947855260674;10672.825989141344;11880.762384752084;12845.421956011814;12910.548130815376;10919.181061420266;11150.330980141218;11166.888331116585;11168.441577921234;11428.885711142782;5056.4037150714985;7537.2462753724185;10588.788224235626;10754;11045.889541104487;9602.95198524003;11124.388158651353;11157.49791259379;11198.272112312674;11553.075753939833;7010.75462358815;7299.5620262784405;7371.447141464519;7439.256074392518;7476.5514069156025;8138.715144969898;10528.36829790215;10574.682759517227;10623.840642390216;10922.29005114665 03:31:16 INFO - PROCESS | 1664 | |3;mootools.html;1474.3733913086935;1523.489630973624;1701.0559139677482;1821.6265665538565;1837.6692195404821;7763.844723105542;8117.594120293991;8317.792055198623;8506.19191176838;9076.137766912141;8465.788355291106;8771.254443372305;8791.07693692161;8872;8881.689140880071;2000.489875081852;2384.3681424422543;2425.745296743843;2430.7083150021936;2434.6469761884514;2219.4673278413147;2245.7529671736097;2391.151141344824;2405.278416475059;2422.6002709552904;2053.537953960362;2393.940151496209;2399.776114181771;2417.721961974369;2424.527217192648;2343.8945247463903;2365.6806331145335;2384.3681424422543;2392.3181893160454;2404.278716385095;2379.1435083369975;2388.295452841416;2401.4236583220077;2411.6864807574902;2412.710474743042;8799.252063574604;8844.292456603456;8859.11408859109;8908.020117787102;8917.73246802597;4622.676412651116;5203.167493201107;5436.10304299794;5441.1838224266285;5453.64551304164;3662.926741465156;3663.4687970244167;3682.410814269731;3682.963170368289;3690;1060.4220699718671;1071.9035286824223;1073.3023534702506;1083.014456844268;1086.5708045322133;11539.942300288529;11557.075433965263;11597.826032609433;11645.70885727855;11668.591599294068;4603.562661547147;4676.50896655853;4853.102176097363;4876.780544875418;4911.582515486152;8588.484690918565;9923.057309555581;10043.497825108861;10051.597936082475;10059.346142500714;5407.783688652488;5408.8377348679605;5409.215663728737;5412.269343638637;5421.756020979065;4440.666949978699;4585.1746685596245;4795.472498025214;4946.183879659816;4952.876178095505;4034.9596504034585;4041.312976793952;4068.6541643960004;4134.545200027995;4181.623653871166;1126.4311522680994;1314.1655049043925;1323.7881938889732;1325.4698120751584;1341.7853143496993;914.6341463414554;919.0763282900775;922.9947370503771;923.1091996223677;950.3110245072268;5642.266505354278;5855.531557475391;5969.31352894414;6128.233970753656;6276.560640755103;436.67685912424577;440.70913197289633;448.4081013062791;454.31398588132157;456.8492397508814;4017.979910100489;4041.515018197835;4063.309237429644;4088.608164223903;4095.4675892133832;10152.23858210637;10700.30448020876;10799.406032668121;10832.295900766425;10853.186011049203;10281.074703276741;10676.199285053652;10743.033127018605;10778.353298802096;10789.946050269698;8059.5164290142775;8120.309773669186;8208.958955205186;8221.917780822116;8222.712205072794;5189.247559103985;5873.559483038704;5881.500072493886;5996.37038110992;6016.669083200466;9894.06006429388;9942.552585133832;9951.601935922483;9982.450965196984;9988.650397236062;9986;10018.64934727281;10033.946435624155;10151.289409741543;10262.281640285108;7070.399016083485;7302.415806735342;7394.704211831467;7518.924810751822;7706.499077559941;8417.957910210409;8514.446560973516;8539.316854651737;8586.871196932176;8592.183742544448;7523.435742319458;7590.278923502258;7635.694572217049;7740.225977402215;7755.961220193863;7402.4448166386655;7457.6271186441545;7533.510321829063;7556.168821429528;7600.42996775233;6966.12923384577;7066.858662826818;7113.430925525842;7113.822154445973;7124.608146551989;4970.701757894538;4994.80020799164;5024.894523204889;5097.8215762448135;5145.4340022598235;5083.237514372874;5127.307813445137;5138.075146473521;5187.429382767968;5199.116150254541 03:31:16 INFO - PROCESS | 1664 | |4;prototype.html;253.50313385763906;297.8198190094991;298.400215566711;311.27007168190585;314.29284110750797;5288;5369.4362091980365;5563.08209145491;5567.526760225381;5677.8580535486635;5312.814051508198;5509.862253443666;5527.889442211163;5591.888162236753;5619.662820230778;4240.97879510602;4283.97858010711;4301.892452688677;4301.935470967938;4314.37441570972;4099.528554216258;4252.4046633471335;4311.892202694927;4328.900483265614;4347.282698354784;3651.543557055368;4176.853810116647;4179.289520781459;4193.9580604194025;4228.281192197319;4217.557156498554;4227.85202517912;4228.344606585984;4281.250781113324;4309.461317335333;3220.130564747505;3309.8580989558563;3568.8936429706873;3586.5875424326277;3622.9275414491826;4624.676272660915;5415.620906536544;5471;5478.274343581759;5486.698231597261;4151;4163.3130533461945;4631.397918270603;4831.704940153434;4833.969732712269;5133.666311689765;5610.635308704962;5912.14273930282;5934.457041169327;5953.553483488712;3476.582810062783;3506.2461570762152;3516.8769093081874;3973.1060511384994;3984.880453586397;5617.578681598897;5719.571032172562;6177.629342239435;6241.8127456175935;6354.110424540568;3669.046048027532;3844.961550384516;3997.200559887976;4005.9799701001307;4043.7169398142437;4058.7564746115327;4077.8776636700945;4094.160697057096;4108.36320370343;4124.216398884202;3893.7079719021185;4691.7654117294;4802.391198948391;4824.228123500223;4827.710337379698;4401.757903315349;5489.807856724996;5731.656100633975;5907.400743672771;5975.52195824333;1187.8812118788053;1305.3473263368317;1327.515456858259;1349.7368013237324;1384.9376778045012;808.8099296665279;893.2764460786653;905.2622112977901;929.4051806843626;936.6674830435234;5068.315777370081;5365.973170134124;5444.433895798258;5466.528754241085;5478.165284301005;5029.698218106925;5177.126694684486;6013.579049466495;6082.635041897501;6097.542684298695;4678.4432790505;5229.973850130725;5345.9465405345445;5473.303275984457;5521.3926468088475;2319.4549280918973;2395.4488469779976;2592.574084253653;2649.8145129840727;2682.7049024607277;4570.3318288825;4701.271302948048;4733.360996265529;4744.7462455334135;5224.294720212799;4239.724417912826;4745.810167593258;4941.357623508921;5023.447420783711;5031.320771695774;4721.716696998191;4893.388326459192;4948.610202011633;5131.7690703918415;5187.014467251135;4521.638268938411;4640.605548528413;4665.300204969281;4894.066843596688;4971.751412429437;4391.155714599812;4557.903364452389;4559;4766.642501812308;4954.355933728736;4631.976840115778;5087.567556757717;5111.134435930933;5153.690778553148;5171.3018742469285;3074;3149.2914094328594;3216.823074730912;3432.6567343265474;3453.8963831085107;3862.806859657062;4771.7116378578285;4794.808207671654;5009.096543313518;5037.697738135724;3746.6351700268883;4081.5510293868247;4089.3048181808567;4189.868735441475;4305.246581848227;4033.983008495752;4156.459660244149;4525.79633916468;4733.573978341966;4903.41159060915;4044.4337792708457;4253.021804984809;4302.784860757012;4728.787204575733;4752.881177970578;4048.1701251242835;4673.859784206479;4785.114753770564;4882.6826256293225;4938.937588971333;4335.853752392586;4422.535633758409;4682.555157260055;4769.523047695203;4813.4945830687275 03:31:16 INFO - PROCESS | 1664 | |5;yui.html;618.5021058048272;687.7970998555426;711.1395211793729;764.8355603545236;807.6325272001241;12741.490340386397;14800.925995370035;15353.923230383847;15960.680786384266;15987.84012159878;14208.289585520733;14286;14295.142291462493;14313.71372572548;14331.426742930296;685.9588424694509;839.2949922065463;868.2663149638545;872.8821609082788;873.7553485024204;696.8118607975844;832.3549249331786;843.3169133002287;859.1623167411786;875.1511034296753;870.5212133326677;911.4576826788051;918.0085507651753;920.7661733277407;923.372106967262;920.4247345409119;921.4379228670573;921.6497730862296;921.8617207418873;921.9032001639832;582.5834528312278;659.2056571830932;680.3944489404435;680.8161796314968;682.1779755394738;14712.48506302285;15129.319180636898;15287;15357.232138393147;15373.385064597403;14678.779818302733;14689.192094434802;14804.555863324118;14956.775648365283;14972.1016738996;10444.26890117692;11333.489992950255;11639.010684091862;11910.523579056828;11984.58053968107;3798.867039653599;3835.7698538087525;3951.9012024699323;3997.480327557399;4052.513698356216;91184;100450.49774751079;101530.47704284442;117457.2381414271;125500;10342.689719308433;10946.56213751457;11290.266132701348;11341.43292835355;11471.885281147082;18650.626987460448;22319.665205021938;22567.88716056442;22629;22764.886175569016;7669.692567785312;8030.718924837603;8037.115917249098;8122.959385203036;8205.466644668077;4341.717788343748;4447.6219521341045;4474.977625111918;4520.59314661682;4550.431196100488;3502.7372947029075;3639.7816131032223;3640.5449318835144;3641.453781932731;3644.890653280406;620.4849974521137;629.0721186250245;648.1412128929094;662.192125606759;690.1063123255396;493.58538827385166;528.923306120618;592.5496622566881;603.8520562462137;629.6788637794758;7183.317584829538;7468.663910124057;7894.60526973649;7967.808036112;9327;498.5263999200774;501.28316507394777;516.8061976758715;562.8846086552247;620.5997131849931;4397.1865204937185;4517.12385163156;4555.453345598549;4559.521250268674;4678.087772884255;128441;153189.23405382902;163059;166332;166361;88047;134308;135299;137440;138708;98213.50893245488;122549.77450225741;123013;123306.38346808388;123928.38035809764;8667.956660216658;9055.592498337723;9591.856122158033;9829.361091529028;10008.699739007841;54011;55731.72134139304;56492.717536412056;57230.7138464305;58365.12452313134;94446;94795;96006.0399396025;96780;96971;12644.873551264738;13125.474981000652;13299.268540229994;13594.048416610742;13761.79357309621;12231.938840305742;14538.273086345853;15305.234738263265;15589.532314030597;16050.277737501607;13774.035817492679;13831.861681383058;13942.58172254834;15005;15015.399384024953;14071.648208794863;14177.078489898124;14197;14336;14339.283035847957;13658.931705341409;13727.656808579866;13737.862621373659;13855.653608659864;14704;10817.296875703054;11047.447627618747;11055.447227638426;11060.723481913017;12127.636170914886;10164.593416263267;10680.465976701289;10832.620858269922;11197.496112674786;11298.943505282421 03:31:16 INFO - PROCESS | 1664 | __end_tp_report 03:31:16 INFO - PROCESS | 1664 | __start_cc_report 03:31:16 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,358 03:31:16 INFO - PROCESS | 1664 | __end_cc_report 03:31:16 INFO - PROCESS | 1664 | __startTimestamp1478950276351__endTimestamp 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | ------- Summary: start ------- 03:31:16 INFO - PROCESS | 1664 | Number of tests: 6 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5790.63 Median:6019.16 stddev:703.54 (11.7%) stddev-sans-first:667.74 03:31:16 INFO - PROCESS | 1664 | Values: 2884.4 3274.7 3312.2 3488.0 3492.1 5822.4 5834.9 5861.0 5903.1 5927.3 5811.2 5888.9 5923.4 5936.0 5976.4 5342.7 5399.4 5429.6 5437.8 5450.4 5406.3 5433.3 5449.2 5450.4 5468.5 5335.0 5335.4 5344.5 5380.2 5481.5 4424.5 5398.8 5406.8 5416.7 5447.1 5223.0 5350.6 5359.5 5376.2 5411.1 5451.6 5688.1 5711.1 5763.5 5840.8 6207.8 6224.1 6233.5 6293.4 6325.9 6317.0 6345.5 6358.2 6362.2 6376.2 5867.6 5894.0 5969.1 5970.7 5994.8 6416.6 6418.1 6419.6 6426.3 6482.0 4506.9 6227.3 6237.7 6310.6 6318.0 4690.0 5061.5 6236.6 6243.4 6266.8 4613.0 5759.9 6089.9 6274.6 6326.9 5704.6 6087.6 6313.9 6342.3 6342.9 4556.0 4797.7 4949.1 4967.4 5006.1 3842.9 4477.7 4494.6 4513.3 4533.5 5627.9 5915.4 5982.9 6019.2 6047.5 6199.8 6302.8 6304.4 6332.2 6358.7 4682.4 5973.1 6003.2 6029.5 6040.0 5390.9 5528.9 5531.6 5556.1 5558.6 6297.8 6459.1 6473.3 6498.6 6523.4 6269.5 6288.4 6296.8 6323.6 6359.4 6410.0 6476.6 6481.0 6489.2 6493.3 6260.5 6290.2 6309.4 6343.0 6351.1 6260.2 6263.5 6278.6 6283.8 6320.2 4909.5 5684.8 5783.9 6202.3 6253.3 6159.4 6240.7 6242.1 6254.3 6258.2 5928.1 5936.2 6043.1 6094.8 6098.2 6221.9 6272.2 6298.5 6301.1 6305.3 6126.1 6145.5 6148.0 6148.9 6166.9 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:73197.53 Median:42331.68 stddev:159004.66 (375.6%) stddev-sans-first:159356.97 03:31:16 INFO - PROCESS | 1664 | Values: 480.2 523.6 532.1 538.7 545.8 40713.0 42459.6 42568.4 42588.0 42600.0 44082.6 44454.6 44699.0 44847.1 44882.8 9850.4 9963.3 10029.2 10054.7 10077.4 9789.1 9790.1 9869.4 9875.9 9917.8 9765.1 9794.4 9869.5 9906.4 9920.6 9733.7 9757.8 9834.8 9888.1 9892.6 9810.8 9831.1 9884.8 9892.3 9898.9 42012.8 42064.0 42185.6 42446.4 42506.9 2690.8 2780.4 2839.4 3543.8 3545.3 28514.3 31868.4 31974.0 32238.5 32257.5 3036.9 3104.6 3140.9 3163.2 3189.9 487533.0 492469.0 493317.0 497830.0 498360.0 50194.0 63017.0 63467.0 63702.0 65360.0 35242.1 35666.8 35954.0 66974.0 67378.0 14520.7 17152.7 17261.2 17398.9 17471.2 13155.2 13245.2 13281.8 13288.1 13329.1 16118.4 19809.7 19993.1 19993.9 20078.7 7553.5 8110.5 8196.5 8210.7 8254.9 883.9 910.5 964.2 996.0 1108.5 31936.5 32478.8 32726.5 32755.0 32993.5 1036.2 1064.5 1087.8 1105.8 1123.6 14600.9 16605.9 16873.2 17241.5 17367.7 656848.0 662666.0 665987.0 666083.0 669930.0 59692.1 60150.4 60176.7 60238.4 60255.7 1167.5 1336.6 1350.5 1383.6 1385.3 25484.0 31573.2 31786.7 31923.4 32967.5 58159.0 58738.8 58960.0 59065.0 59120.0 606800.0 609405.0 612762.0 621131.0 623014.0 43926.6 44125.0 44716.9 45076.1 45087.8 49590.5 49634.8 49643.0 49695.8 50123.7 40729.8 40852.8 41232.4 41969.6 42211.4 37794.0 40742.0 40782.8 41539.6 42217.0 32994.0 38986.6 39118.8 39221.0 40138.0 34514.8 35830.8 36127.5 36243.0 36388.0 26506.7 26639.6 26664.1 26707.1 26977.6 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35490.46 Median:13700.95 stddev:96673.44 (705.6%) stddev-sans-first:96908.60 03:31:16 INFO - PROCESS | 1664 | Values: 340.9 374.4 379.4 380.0 386.7 19570.8 19954.5 20681.9 20717.7 20871.0 11480.2 11890.5 11894.6 11898.8 13099.8 5242.7 5489.4 5518.4 5521.2 5522.0 3917.0 4125.8 4145.8 5426.1 5948.2 6209.3 6604.6 6847.4 6928.5 6934.2 6106.9 6155.0 6166.4 6548.5 6925.1 5812.7 5934.8 5939.6 5955.6 5988.3 22583.3 23245.6 25124.9 25305.2 27061.0 2038.9 2428.9 2519.9 2530.9 2558.4 13378.6 16161.0 17014.7 17576.9 17706.2 1893.9 1976.7 1981.8 2023.5 2036.8 115365.4 115771.4 117449.0 132079.3 138853.3 17027.6 21438.7 22218.0 22284.3 22600.1 35620.3 35783.9 36323.1 36393.0 36457.5 10124.6 10994.3 11048.2 11282.0 11752.9 9161.4 9290.4 9291.3 9307.7 9459.0 9954.1 10118.7 10122.9 10136.8 10156.1 3867.5 3907.5 3963.4 3970.3 3974.7 853.2 905.3 922.2 961.7 978.1 20180.8 20609.7 20817.2 21231.0 21454.0 919.7 922.9 929.3 970.7 1023.3 10833.1 11250.3 11264.9 11287.9 11293.8 556771.0 568723.2 584116.0 591722.0 592806.0 107887.0 121098.4 124949.4 125799.0 126950.0 944.5 952.9 970.4 975.7 976.0 18515.4 18813.8 18877.6 18900.9 18981.4 51319.0 51543.5 52944.5 56226.0 57008.9 78091.0 78263.6 79595.0 79695.8 79824.0 7130.8 7260.5 7629.6 7953.4 8349.6 10428.9 10672.8 11880.8 12845.4 12910.5 10919.2 11150.3 11166.9 11168.4 11428.9 5056.4 7537.2 10588.8 10754.0 11045.9 9603.0 11124.4 11157.5 11198.3 11553.1 7010.8 7299.6 7371.4 7439.3 7476.6 8138.7 10528.4 10574.7 10623.8 10922.3 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5726.75 Median:4928.88 stddev:3200.59 (64.9%) stddev-sans-first:3193.61 03:31:16 INFO - PROCESS | 1664 | Values: 1474.4 1523.5 1701.1 1821.6 1837.7 7763.8 8117.6 8317.8 8506.2 9076.1 8465.8 8771.3 8791.1 8872.0 8881.7 2000.5 2384.4 2425.7 2430.7 2434.6 2219.5 2245.8 2391.2 2405.3 2422.6 2053.5 2393.9 2399.8 2417.7 2424.5 2343.9 2365.7 2384.4 2392.3 2404.3 2379.1 2388.3 2401.4 2411.7 2412.7 8799.3 8844.3 8859.1 8908.0 8917.7 4622.7 5203.2 5436.1 5441.2 5453.6 3662.9 3663.5 3682.4 3683.0 3690.0 1060.4 1071.9 1073.3 1083.0 1086.6 11539.9 11557.1 11597.8 11645.7 11668.6 4603.6 4676.5 4853.1 4876.8 4911.6 8588.5 9923.1 10043.5 10051.6 10059.3 5407.8 5408.8 5409.2 5412.3 5421.8 4440.7 4585.2 4795.5 4946.2 4952.9 4035.0 4041.3 4068.7 4134.5 4181.6 1126.4 1314.2 1323.8 1325.5 1341.8 914.6 919.1 923.0 923.1 950.3 5642.3 5855.5 5969.3 6128.2 6276.6 436.7 440.7 448.4 454.3 456.8 4018.0 4041.5 4063.3 4088.6 4095.5 10152.2 10700.3 10799.4 10832.3 10853.2 10281.1 10676.2 10743.0 10778.4 10789.9 8059.5 8120.3 8209.0 8221.9 8222.7 5189.2 5873.6 5881.5 5996.4 6016.7 9894.1 9942.6 9951.6 9982.5 9988.7 9986.0 10018.6 10033.9 10151.3 10262.3 7070.4 7302.4 7394.7 7518.9 7706.5 8418.0 8514.4 8539.3 8586.9 8592.2 7523.4 7590.3 7635.7 7740.2 7756.0 7402.4 7457.6 7533.5 7556.2 7600.4 6966.1 7066.9 7113.4 7113.8 7124.6 4970.7 4994.8 5024.9 5097.8 5145.4 5083.2 5127.3 5138.1 5187.4 5199.1 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4311.79 Median:4676.15 stddev:1305.10 (27.9%) stddev-sans-first:1272.72 03:31:16 INFO - PROCESS | 1664 | Values: 253.5 297.8 298.4 311.3 314.3 5288.0 5369.4 5563.1 5567.5 5677.9 5312.8 5509.9 5527.9 5591.9 5619.7 4241.0 4284.0 4301.9 4301.9 4314.4 4099.5 4252.4 4311.9 4328.9 4347.3 3651.5 4176.9 4179.3 4194.0 4228.3 4217.6 4227.9 4228.3 4281.3 4309.5 3220.1 3309.9 3568.9 3586.6 3622.9 4624.7 5415.6 5471.0 5478.3 5486.7 4151.0 4163.3 4631.4 4831.7 4834.0 5133.7 5610.6 5912.1 5934.5 5953.6 3476.6 3506.2 3516.9 3973.1 3984.9 5617.6 5719.6 6177.6 6241.8 6354.1 3669.0 3845.0 3997.2 4006.0 4043.7 4058.8 4077.9 4094.2 4108.4 4124.2 3893.7 4691.8 4802.4 4824.2 4827.7 4401.8 5489.8 5731.7 5907.4 5975.5 1187.9 1305.3 1327.5 1349.7 1384.9 808.8 893.3 905.3 929.4 936.7 5068.3 5366.0 5444.4 5466.5 5478.2 5029.7 5177.1 6013.6 6082.6 6097.5 4678.4 5230.0 5345.9 5473.3 5521.4 2319.5 2395.4 2592.6 2649.8 2682.7 4570.3 4701.3 4733.4 4744.7 5224.3 4239.7 4745.8 4941.4 5023.4 5031.3 4721.7 4893.4 4948.6 5131.8 5187.0 4521.6 4640.6 4665.3 4894.1 4971.8 4391.2 4557.9 4559.0 4766.6 4954.4 4632.0 5087.6 5111.1 5153.7 5171.3 3074.0 3149.3 3216.8 3432.7 3453.9 3862.8 4771.7 4794.8 5009.1 5037.7 3746.6 4081.6 4089.3 4189.9 4305.2 4034.0 4156.5 4525.8 4733.6 4903.4 4044.4 4253.0 4302.8 4728.8 4752.9 4048.2 4673.9 4785.1 4882.7 4938.9 4335.9 4422.5 4682.6 4769.5 4813.5 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:25126.13 Median:3641.00 stddev:40706.95 (1118.0%) stddev-sans-first:40779.55 03:31:16 INFO - PROCESS | 1664 | Values: 618.5 687.8 711.1 764.8 807.6 12741.5 14800.9 15353.9 15960.7 15987.8 14208.3 14286.0 14295.1 14313.7 14331.4 686.0 839.3 868.3 872.9 873.8 696.8 832.4 843.3 859.2 875.2 870.5 911.5 918.0 920.8 923.4 920.4 921.4 921.6 921.9 921.9 582.6 659.2 680.4 680.8 682.2 14712.5 15129.3 15287.0 15357.2 15373.4 14678.8 14689.2 14804.6 14956.8 14972.1 10444.3 11333.5 11639.0 11910.5 11984.6 3798.9 3835.8 3951.9 3997.5 4052.5 91184.0 100450.5 101530.5 117457.2 125500.0 10342.7 10946.6 11290.3 11341.4 11471.9 18650.6 22319.7 22567.9 22629.0 22764.9 7669.7 8030.7 8037.1 8123.0 8205.5 4341.7 4447.6 4475.0 4520.6 4550.4 3502.7 3639.8 3640.5 3641.5 3644.9 620.5 629.1 648.1 662.2 690.1 493.6 528.9 592.5 603.9 629.7 7183.3 7468.7 7894.6 7967.8 9327.0 498.5 501.3 516.8 562.9 620.6 4397.2 4517.1 4555.5 4559.5 4678.1 128441.0 153189.2 163059.0 166332.0 166361.0 88047.0 134308.0 135299.0 137440.0 138708.0 98213.5 122549.8 123013.0 123306.4 123928.4 8668.0 9055.6 9591.9 9829.4 10008.7 54011.0 55731.7 56492.7 57230.7 58365.1 94446.0 94795.0 96006.0 96780.0 96971.0 12644.9 13125.5 13299.3 13594.0 13761.8 12231.9 14538.3 15305.2 15589.5 16050.3 13774.0 13831.9 13942.6 15005.0 15015.4 14071.6 14177.1 14197.0 14336.0 14339.3 13658.9 13727.7 13737.9 13855.7 14704.0 10817.3 11047.4 11055.4 11060.7 12127.6 10164.6 10680.5 10832.6 11197.5 11298.9 03:31:16 INFO - PROCESS | 1664 | -------- Summary: end -------- 03:31:16 INFO - PROCESS | 1664 | 03:31:16 INFO - TEST-INFO | 1664: exit 0 03:31:16 INFO - TEST-OK | dromaeo_css | took 1114570ms 03:31:16 INFO - TEST-START | kraken 03:31:16 INFO - operating with platform_type : mac_ 03:31:16 INFO - Initialising browser for kraken test... 03:31:16 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpepZ5jA/profile http://localhost:49267/getInfo.html) 03:31:19 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 03:31:19 INFO - PROCESS | 1676 | colorDepth:24 03:31:19 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 03:31:19 INFO - PROCESS | 1676 | __metrics 03:31:19 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:31:20 INFO - TEST-INFO | 1676: exit 0 03:31:20 INFO - Browser initialized. 03:31:20 INFO - Running cycle 1/1 for kraken test... 03:31:20 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpepZ5jA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:32 INFO - PROCESS | 1679 | RSS: Main: 225595392 03:31:32 INFO - PROCESS | 1679 | 03:31:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:36 INFO - PROCESS | 1679 | RSS: Main: 238149632 03:31:36 INFO - PROCESS | 1679 | 03:31:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 03:31:39 INFO - PROCESS | 1679 | RSS: Main: 246079488 03:31:39 INFO - PROCESS | 1679 | 03:31:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 03:31:43 INFO - PROCESS | 1679 | RSS: Main: 249282560 03:31:43 INFO - PROCESS | 1679 | 03:31:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 03:31:46 INFO - PROCESS | 1679 | RSS: Main: 249446400 03:31:46 INFO - PROCESS | 1679 | 03:31:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:48 INFO - PROCESS | 1679 | RSS: Main: 250949632 03:31:48 INFO - PROCESS | 1679 | 03:31:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:52 INFO - PROCESS | 1679 | RSS: Main: 251834368 03:31:52 INFO - PROCESS | 1679 | 03:31:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:56 INFO - PROCESS | 1679 | RSS: Main: 251908096 03:31:56 INFO - PROCESS | 1679 | 03:31:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 03:31:59 INFO - PROCESS | 1679 | RSS: Main: 252162048 03:31:59 INFO - PROCESS | 1679 | 03:32:01 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:32:02 INFO - PROCESS | 1679 | RSS: Main: 251363328 03:32:02 INFO - PROCESS | 1679 | 03:32:04 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:32:05 INFO - PROCESS | 1679 | RSS: Main: 251392000 03:32:05 INFO - PROCESS | 1679 | 03:32:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:32:07 INFO - PROCESS | 1679 | RSS: Main: 251506688 03:32:07 INFO - PROCESS | 1679 | 03:32:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:32:11 INFO - PROCESS | 1679 | RSS: Main: 251867136 03:32:11 INFO - PROCESS | 1679 | 03:32:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:32:14 INFO - PROCESS | 1679 | RSS: Main: 251527168 03:32:14 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 03:32:16 INFO - PROCESS | 1679 | RSS: Main: 252919808 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | __start_tp_report 03:32:16 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 03:32:16 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 03:32:16 INFO - PROCESS | 1679 | |i|pagename|runs| 03:32:16 INFO - PROCESS | 1679 | |0;ai-astar;126;151;174;101;160;176;176;117;119;116 03:32:16 INFO - PROCESS | 1679 | |1;audio-beat-detection;186;113;98;181;142;143;112;141;178;112 03:32:16 INFO - PROCESS | 1679 | |2;audio-dft;199;197;229;224;199;201;196;199;197;202 03:32:16 INFO - PROCESS | 1679 | |3;audio-fft;70;57;59;82;59;60;57;56;72;72 03:32:16 INFO - PROCESS | 1679 | |4;audio-oscillator;91;68;88;73;69;72;119;55;80;115 03:32:16 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;89;87;100;132;90;85;89;86;88;87 03:32:16 INFO - PROCESS | 1679 | |6;imaging-darkroom;100;149;120;107;102;97;106;97;95;118 03:32:16 INFO - PROCESS | 1679 | |7;imaging-desaturate;119;118;88;92;80;147;136;143;125;150 03:32:16 INFO - PROCESS | 1679 | |8;json-parse-financial;56;57;59;88;92;91;51;60;90;93 03:32:16 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;64;85;87;74;115;103;107;107;80;71 03:32:16 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;87;83;88;84;86;87;85;87;83;91 03:32:16 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;138;137;139;138;140;146;154;159;191;156 03:32:16 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;165;168;165;166;165;170;165;168;168;168 03:32:16 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;69;68;69;67;69;68;67;70;68;69 03:32:16 INFO - PROCESS | 1679 | __end_tp_report 03:32:16 INFO - PROCESS | 1679 | __start_cc_report 03:32:16 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,951 03:32:16 INFO - PROCESS | 1679 | __end_cc_report 03:32:16 INFO - PROCESS | 1679 | __startTimestamp1478950336842__endTimestamp 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | ------- Summary: start ------- 03:32:16 INFO - PROCESS | 1679 | Number of tests: 14 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:141.60 Median:155.50 stddev:28.88 (18.6%) stddev-sans-first:30.07 03:32:16 INFO - PROCESS | 1679 | Values: 126.0 151.0 174.0 101.0 160.0 176.0 176.0 117.0 119.0 116.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:160.50 stddev:32.17 (20.0%) stddev-sans-first:29.63 03:32:16 INFO - PROCESS | 1679 | Values: 186.0 113.0 98.0 181.0 142.0 143.0 112.0 141.0 178.0 112.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:204.30 Median:200.00 stddev:11.90 (5.9%) stddev-sans-first:12.46 03:32:16 INFO - PROCESS | 1679 | Values: 199.0 197.0 229.0 224.0 199.0 201.0 196.0 199.0 197.0 202.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:64.40 Median:65.00 stddev:8.91 (13.7%) stddev-sans-first:9.22 03:32:16 INFO - PROCESS | 1679 | Values: 70.0 57.0 59.0 82.0 59.0 60.0 57.0 56.0 72.0 72.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:72.50 stddev:20.67 (28.5%) stddev-sans-first:21.72 03:32:16 INFO - PROCESS | 1679 | Values: 91.0 68.0 88.0 73.0 69.0 72.0 119.0 55.0 80.0 115.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:87.50 stddev:14.22 (16.3%) stddev-sans-first:15.00 03:32:16 INFO - PROCESS | 1679 | Values: 89.0 87.0 100.0 132.0 90.0 85.0 89.0 86.0 88.0 87.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:109.10 Median:134.50 stddev:16.43 (12.2%) stddev-sans-first:17.09 03:32:16 INFO - PROCESS | 1679 | Values: 100.0 149.0 120.0 107.0 102.0 97.0 106.0 97.0 95.0 118.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:119.80 Median:148.50 stddev:25.50 (17.2%) stddev-sans-first:27.04 03:32:16 INFO - PROCESS | 1679 | Values: 119.0 118.0 88.0 92.0 80.0 147.0 136.0 143.0 125.0 150.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:73.70 Median:89.00 stddev:18.22 (20.5%) stddev-sans-first:18.17 03:32:16 INFO - PROCESS | 1679 | Values: 56.0 57.0 59.0 88.0 92.0 91.0 51.0 60.0 90.0 93.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:89.30 Median:72.50 stddev:17.62 (24.3%) stddev-sans-first:16.14 03:32:16 INFO - PROCESS | 1679 | Values: 64.0 85.0 87.0 74.0 115.0 103.0 107.0 107.0 80.0 71.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:2.47 (2.8%) stddev-sans-first:2.60 03:32:16 INFO - PROCESS | 1679 | Values: 87.0 83.0 88.0 84.0 86.0 87.0 85.0 87.0 83.0 91.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:150.00 stddev:16.69 (11.1%) stddev-sans-first:17.15 03:32:16 INFO - PROCESS | 1679 | Values: 138.0 137.0 139.0 138.0 140.0 146.0 154.0 159.0 191.0 156.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:168.00 stddev:1.81 (1.1%) stddev-sans-first:1.80 03:32:16 INFO - PROCESS | 1679 | Values: 165.0 168.0 165.0 166.0 165.0 170.0 165.0 168.0 168.0 168.0 03:32:16 INFO - PROCESS | 1679 | 03:32:16 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 03:32:16 INFO - PROCESS | 1679 | Values: 69.0 68.0 69.0 67.0 69.0 68.0 67.0 70.0 68.0 69.0 03:32:16 INFO - PROCESS | 1679 | -------- Summary: end -------- 03:32:16 INFO - PROCESS | 1679 | 03:32:17 INFO - TEST-INFO | 1679: exit 0 03:32:17 INFO - TEST-OK | kraken | took 60677ms 03:32:17 INFO - SUITE-END | took 1175s 03:32:18 INFO - Completed test suite (00:19:35) 03:32:18 INFO - javascript benchmark 03:32:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7444.5528196416835, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2884.3654396032894, 3274.7216486598636, 3312.188513814115, 3487.982560087199, 3492.1444246159695, 5822.4177582241755, 5834.912476312853, 5861.0, 5903.055511118217, 5927.2590926134235, 5811.186433899247, 5888.941110588893, 5923.407659234074, 5936.0, 5976.37248088952, 5342.652727572715, 5399.40606533283, 5429.647072940246, 5437.782488700447, 5450.400455949843, 5406.270153529263, 5433.26650902129, 5449.155380915964, 5450.427705090968, 5468.48049435303, 5335.013022590813, 5335.359756829166, 5344.4922732340365, 5380.192971054334, 5481.5340696040885, 4424.535423780505, 5398.78404863805, 5406.783728650849, 5416.729163541847, 5447.101228297326, 5222.97388513055, 5350.602947744514, 5359.490848369399, 5376.247325374412, 5411.107167317427, 5451.618386712892, 5688.089905615082, 5711.143328500717, 5763.5101016413655, 5840.766369345263, 6207.751689932397, 6224.066390041485, 6233.470155036827, 6293.433590976834, 6325.936740632626, 6316.968415157895, 6345.49236061114, 6358.173437453148, 6362.236531616236, 6376.202974628171, 5867.559933004956, 5894.0274854648505, 5969.074793407029, 5970.701464926737, 5994.760209591567, 6416.615003099829, 6418.133551970424, 6419.614823110535, 6426.2931077581425, 6481.967590162019, 4506.932396014063, 6227.346128656426, 6237.688115594202, 6310.5898116622275, 6317.9684101580115, 4689.95310046902, 5061.468545802712, 6236.563440559117, 6243.375662433811, 6266.780662676784, 4613.031263434649, 5759.94240057594, 6089.939100608937, 6274.560780745304, 6326.905096423558, 5704.573856535866, 6087.604305720114, 6313.905291420632, 6342.302346741854, 6342.904856427157, 4555.954440455619, 4797.664163508591, 4949.1091603510995, 4967.403911530567, 5006.07387633289, 3842.9231415371537, 4477.7313361197785, 4494.595486406239, 4513.277875539898, 4533.501314855429, 5627.915581266284, 5915.438033386821, 5982.880342393128, 6019.157317975487, 6047.485963693048, 6199.752009919553, 6302.779402720883, 6304.356498843058, 6332.240131184288, 6358.745650173942, 4682.4381074271305, 5973.1338955852025, 6003.159557661931, 6029.457348838538, 6039.969800150971, 5390.865228369244, 5528.889422211533, 5531.612787104945, 5556.138798486241, 5558.610897237155, 6297.842553936188, 6459.128017717548, 6473.320301368382, 6498.610083395011, 6523.445507131947, 6269.467095296951, 6288.434040936338, 6296.842578935563, 6323.557350985387, 6359.395857393541, 6409.9679501602195, 6476.643784591704, 6480.967595161994, 6489.221293444817, 6493.253275873146, 6260.530460215411, 6290.21372328459, 6309.432151106423, 6342.9682851587295, 6351.110844481868, 6260.154879091265, 6263.530235232467, 6278.591891527036, 6283.842903927439, 6320.209973753281, 4909.4845041270155, 5684.8294551163535, 5783.942160578508, 6202.255729312511, 6253.343398943045, 6159.445649891352, 6240.687965601793, 6242.063690446469, 6254.2807577129215, 6258.186435763321, 5928.081147422156, 5936.22829032223, 6043.09353596964, 6094.8171554853425, 6098.237720284965, 6221.906671399842, 6272.153259309935, 6298.527610429144, 6301.086342480223, 6305.337939516468, 6126.08108783686, 6145.477634401126, 6147.969260153671, 6148.907766383419, 6166.907496387468], "value": 5746.439576113345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.20765736534713, 523.6151428699906, 532.0529457565535, 538.7279423890933, 545.7816873250702, 40713.0, 42459.575404245945, 42568.361474577905, 42587.99999999996, 42600.0, 44082.55917440833, 44454.55545444544, 44699.0, 44847.103057938824, 44882.77558612211, 9850.408975461478, 9963.302568820185, 10029.24780641451, 10054.698359049204, 10077.395356278646, 9789.118979291863, 9790.06994335537, 9869.358491698053, 9875.90124098757, 9917.75205619858, 9765.12113909748, 9794.412335259907, 9869.506524673774, 9906.405615663047, 9920.553575089138, 9733.707988760349, 9757.756056098584, 9834.803303933917, 9888.060634239771, 9892.604295828158, 9810.754731131707, 9831.115199631997, 9884.80230395388, 9892.30753847231, 9898.851517227247, 42012.78993605043, 42064.0, 42185.578144218474, 42446.363304550454, 42506.937326566775, 2690.757831795148, 2780.374415756459, 2839.4037252176863, 3543.7519373643854, 3545.2732189901267, 28514.287142821388, 31868.36263274745, 31974.0, 32238.516422253684, 32257.51613725796, 3036.9392612147853, 3104.58088158098, 3140.905772826819, 3163.225009872573, 3189.8883539076255, 487533.0, 492469.0, 493317.0, 497830.0, 498360.0, 50194.0, 63017.0, 63467.0, 63702.0, 65360.0, 35242.118947026014, 35666.82166589202, 35954.0, 66974.0, 67378.0, 14520.709585808225, 17152.742708859376, 17261.223244954006, 17398.913005434893, 17471.213795379237, 13155.210687358598, 13245.20528768277, 13281.800772988412, 13288.06983511145, 13329.06696531253, 16118.435854745028, 19809.702854457195, 19993.100310486065, 19993.90033548169, 20078.69881951772, 7553.509021913558, 8110.472819266847, 8196.508209507449, 8210.671573137008, 8254.917450825535, 883.8762573239752, 910.4628269321, 964.2334344196381, 995.9990209839066, 1108.490094556513, 31936.520952185736, 32478.83760581182, 32726.509102363485, 32755.0, 32993.50509742356, 1036.1917704190744, 1064.4730858225228, 1087.8205096159204, 1105.8064838653204, 1123.612353737959, 14600.926995365167, 16605.91697041507, 16873.240704168096, 17241.482755517103, 17367.65264694699, 656848.0, 662666.0, 665987.0, 666083.0, 669930.0, 59692.104618430756, 60150.398496015354, 60176.66378392507, 60238.39761602416, 60255.69872150611, 1167.5271515036593, 1336.6457888659513, 1350.540816122523, 1383.578008707354, 1385.3419625677723, 25484.0, 31573.210669733442, 31786.682133178372, 31923.36153276875, 32967.50548741819, 58159.0, 58738.82522349615, 58960.0, 59065.0, 59120.0, 606800.0, 609405.0, 612762.0, 621131.0, 623014.0, 43926.560734392246, 44125.0, 44716.882077948314, 45076.09847803091, 45087.774561126986, 49590.50409495859, 49634.75182624064, 49643.0, 49695.751521242164, 50123.74938125286, 40729.796351018056, 40852.79573602113, 41232.38151427671, 41969.580304197785, 42211.36682949697, 37794.0, 40742.0, 40782.796086020564, 41539.58460415357, 42217.0, 32994.0, 38986.6101338983, 39118.80440597779, 39221.0, 40137.996550085314, 34514.82742586271, 35830.82084589561, 36127.45808812817, 36243.0, 36388.0, 26506.734932650426, 26639.60040599431, 26664.06675766339, 26707.06525271606, 26977.595336070368], "value": 20774.877964964515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.9079548521899, 374.4028274901532, 379.3891834147023, 379.990500237494, 386.6713293700353, 19570.804291957076, 19954.50113747157, 20681.896590517044, 20717.68923466149, 20871.0, 11480.196386252966, 11890.46492907819, 11894.64316070517, 11898.821517677241, 13099.803502947463, 5242.659227150242, 5489.368722596892, 5518.448155184489, 5521.2270282160525, 5522.0336441122645, 3916.9608303917025, 4125.793710314488, 4145.7719825409595, 5426.131818908975, 5948.167256584082, 6209.316975132731, 6604.636744979024, 6847.417969472601, 6928.515003949726, 6934.202566704817, 6106.8778624427705, 6154.96922515389, 6166.445019948226, 6548.511565605063, 6925.134358205224, 5812.738426770806, 5934.813037392496, 5939.613925094855, 5955.583109182316, 5988.31134419543, 22583.322500325015, 23245.605263684232, 25124.869380877903, 25305.240842774747, 27061.0, 2038.8572799904014, 2428.86641234732, 2519.8740062996776, 2530.9114181003574, 2558.424354520218, 13378.598642040753, 16161.0, 17014.659706805796, 17576.91211543947, 17706.20322085509, 1893.8579606529427, 1976.723258743777, 1981.782003979561, 2023.5345870449733, 2036.7963203679512, 115365.42317288443, 115771.42114289459, 117449.0, 132079.33960330233, 138853.3057334717, 17027.574310642332, 21438.678419823715, 22218.0, 22284.331470055924, 22600.09599615997, 35620.28759424797, 35783.92648220558, 36323.091922702144, 36393.0, 36457.54169833177, 10124.645637402655, 10994.34033957965, 11048.226624136234, 11282.041026512674, 11752.88347606976, 9161.404508706913, 9290.396124251902, 9291.349605527548, 9307.720403147005, 9458.95270523643, 9954.104130628279, 10118.696439106838, 10122.88648248692, 10136.783585969732, 10156.136728378171, 3867.5165604299464, 3907.5115610548683, 3963.365861462152, 3970.285348637273, 3974.741641793332, 853.1894700034992, 905.3300557587338, 922.2207234886645, 961.7499450143014, 978.1099199728213, 20180.798192018185, 20609.690854637192, 20817.1673133076, 21231.0, 21454.0, 919.7148883846029, 922.9492377919279, 929.340168480373, 970.679675707015, 1023.3348323589578, 10833.05005099074, 11250.268732532359, 11264.887351126548, 11287.943560282147, 11293.830592541119, 556771.0, 568723.1563842237, 584116.0, 591722.0, 592806.0, 107887.0, 121098.39450802689, 124949.37525312316, 125798.99999999817, 126950.0, 944.5466176235445, 952.8904176019569, 970.403202030746, 975.6780262513354, 975.9853602195973, 18515.35196268124, 18813.811861881753, 18877.622447550697, 18900.905495472984, 18981.43055708331, 51318.97362052813, 51543.48456515387, 52944.4705552955, 56226.0, 57008.859822804145, 78091.0, 78263.60868195622, 79595.0, 79695.80456293044, 79824.0, 7130.750423735144, 7260.528065675714, 7629.618519074135, 7953.443258971816, 8349.624266908126, 10428.947855260674, 10672.825989141344, 11880.762384752084, 12845.421956011814, 12910.548130815376, 10919.181061420266, 11150.330980141218, 11166.888331116585, 11168.441577921234, 11428.885711142782, 5056.4037150714985, 7537.2462753724185, 10588.788224235626, 10754.0, 11045.889541104487, 9602.95198524003, 11124.388158651353, 11157.49791259379, 11198.272112312674, 11553.075753939833, 7010.75462358815, 7299.5620262784405, 7371.447141464519, 7439.256074392518, 7476.5514069156025, 8138.715144969898, 10528.36829790215, 10574.682759517227, 10623.840642390216, 10922.29005114665], "value": 10366.948888272042, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.3733913086935, 1523.489630973624, 1701.0559139677482, 1821.6265665538565, 1837.6692195404821, 7763.844723105542, 8117.594120293991, 8317.792055198623, 8506.19191176838, 9076.137766912141, 8465.788355291106, 8771.254443372305, 8791.07693692161, 8872.0, 8881.689140880071, 2000.489875081852, 2384.3681424422543, 2425.745296743843, 2430.7083150021936, 2434.6469761884514, 2219.4673278413147, 2245.7529671736097, 2391.151141344824, 2405.278416475059, 2422.6002709552904, 2053.537953960362, 2393.940151496209, 2399.776114181771, 2417.721961974369, 2424.527217192648, 2343.8945247463903, 2365.6806331145335, 2384.3681424422543, 2392.3181893160454, 2404.278716385095, 2379.1435083369975, 2388.295452841416, 2401.4236583220077, 2411.6864807574902, 2412.710474743042, 8799.252063574604, 8844.292456603456, 8859.11408859109, 8908.020117787102, 8917.73246802597, 4622.676412651116, 5203.167493201107, 5436.10304299794, 5441.1838224266285, 5453.64551304164, 3662.926741465156, 3663.4687970244167, 3682.410814269731, 3682.963170368289, 3690.0, 1060.4220699718671, 1071.9035286824223, 1073.3023534702506, 1083.014456844268, 1086.5708045322133, 11539.942300288529, 11557.075433965263, 11597.826032609433, 11645.70885727855, 11668.591599294068, 4603.562661547147, 4676.50896655853, 4853.102176097363, 4876.780544875418, 4911.582515486152, 8588.484690918565, 9923.057309555581, 10043.497825108861, 10051.597936082475, 10059.346142500714, 5407.783688652488, 5408.8377348679605, 5409.215663728737, 5412.269343638637, 5421.756020979065, 4440.666949978699, 4585.1746685596245, 4795.472498025214, 4946.183879659816, 4952.876178095505, 4034.9596504034585, 4041.312976793952, 4068.6541643960004, 4134.545200027995, 4181.623653871166, 1126.4311522680994, 1314.1655049043925, 1323.7881938889732, 1325.4698120751584, 1341.7853143496993, 914.6341463414554, 919.0763282900775, 922.9947370503771, 923.1091996223677, 950.3110245072268, 5642.266505354278, 5855.531557475391, 5969.31352894414, 6128.233970753656, 6276.560640755103, 436.67685912424577, 440.70913197289633, 448.4081013062791, 454.31398588132157, 456.8492397508814, 4017.979910100489, 4041.515018197835, 4063.309237429644, 4088.608164223903, 4095.4675892133832, 10152.23858210637, 10700.30448020876, 10799.406032668121, 10832.295900766425, 10853.186011049203, 10281.074703276741, 10676.199285053652, 10743.033127018605, 10778.353298802096, 10789.946050269698, 8059.5164290142775, 8120.309773669186, 8208.958955205186, 8221.917780822116, 8222.712205072794, 5189.247559103985, 5873.559483038704, 5881.500072493886, 5996.37038110992, 6016.669083200466, 9894.06006429388, 9942.552585133832, 9951.601935922483, 9982.450965196984, 9988.650397236062, 9986.0, 10018.64934727281, 10033.946435624155, 10151.289409741543, 10262.281640285108, 7070.399016083485, 7302.415806735342, 7394.704211831467, 7518.924810751822, 7706.499077559941, 8417.957910210409, 8514.446560973516, 8539.316854651737, 8586.871196932176, 8592.183742544448, 7523.435742319458, 7590.278923502258, 7635.694572217049, 7740.225977402215, 7755.961220193863, 7402.4448166386655, 7457.6271186441545, 7533.510321829063, 7556.168821429528, 7600.42996775233, 6966.12923384577, 7066.858662826818, 7113.430925525842, 7113.822154445973, 7124.608146551989, 4970.701757894538, 4994.80020799164, 5024.894523204889, 5097.8215762448135, 5145.4340022598235, 5083.237514372874, 5127.307813445137, 5138.075146473521, 5187.429382767968, 5199.116150254541], "value": 4534.760851760089, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.50313385763906, 297.8198190094991, 298.400215566711, 311.27007168190585, 314.29284110750797, 5288.0, 5369.4362091980365, 5563.08209145491, 5567.526760225381, 5677.8580535486635, 5312.814051508198, 5509.862253443666, 5527.889442211163, 5591.888162236753, 5619.662820230778, 4240.97879510602, 4283.97858010711, 4301.892452688677, 4301.935470967938, 4314.37441570972, 4099.528554216258, 4252.4046633471335, 4311.892202694927, 4328.900483265614, 4347.282698354784, 3651.543557055368, 4176.853810116647, 4179.289520781459, 4193.9580604194025, 4228.281192197319, 4217.557156498554, 4227.85202517912, 4228.344606585984, 4281.250781113324, 4309.461317335333, 3220.130564747505, 3309.8580989558563, 3568.8936429706873, 3586.5875424326277, 3622.9275414491826, 4624.676272660915, 5415.620906536544, 5471.0, 5478.274343581759, 5486.698231597261, 4151.0, 4163.3130533461945, 4631.397918270603, 4831.704940153434, 4833.969732712269, 5133.666311689765, 5610.635308704962, 5912.14273930282, 5934.457041169327, 5953.553483488712, 3476.582810062783, 3506.2461570762152, 3516.8769093081874, 3973.1060511384994, 3984.880453586397, 5617.578681598897, 5719.571032172562, 6177.629342239435, 6241.8127456175935, 6354.110424540568, 3669.046048027532, 3844.961550384516, 3997.200559887976, 4005.9799701001307, 4043.7169398142437, 4058.7564746115327, 4077.8776636700945, 4094.160697057096, 4108.36320370343, 4124.216398884202, 3893.7079719021185, 4691.7654117294, 4802.391198948391, 4824.228123500223, 4827.710337379698, 4401.757903315349, 5489.807856724996, 5731.656100633975, 5907.400743672771, 5975.52195824333, 1187.8812118788053, 1305.3473263368317, 1327.515456858259, 1349.7368013237324, 1384.9376778045012, 808.8099296665279, 893.2764460786653, 905.2622112977901, 929.4051806843626, 936.6674830435234, 5068.315777370081, 5365.973170134124, 5444.433895798258, 5466.528754241085, 5478.165284301005, 5029.698218106925, 5177.126694684486, 6013.579049466495, 6082.635041897501, 6097.542684298695, 4678.4432790505, 5229.973850130725, 5345.9465405345445, 5473.303275984457, 5521.3926468088475, 2319.4549280918973, 2395.4488469779976, 2592.574084253653, 2649.8145129840727, 2682.7049024607277, 4570.3318288825, 4701.271302948048, 4733.360996265529, 4744.7462455334135, 5224.294720212799, 4239.724417912826, 4745.810167593258, 4941.357623508921, 5023.447420783711, 5031.320771695774, 4721.716696998191, 4893.388326459192, 4948.610202011633, 5131.7690703918415, 5187.014467251135, 4521.638268938411, 4640.605548528413, 4665.300204969281, 4894.066843596688, 4971.751412429437, 4391.155714599812, 4557.903364452389, 4559.0, 4766.642501812308, 4954.355933728736, 4631.976840115778, 5087.567556757717, 5111.134435930933, 5153.690778553148, 5171.3018742469285, 3074.0, 3149.2914094328594, 3216.823074730912, 3432.6567343265474, 3453.8963831085107, 3862.806859657062, 4771.7116378578285, 4794.808207671654, 5009.096543313518, 5037.697738135724, 3746.6351700268883, 4081.5510293868247, 4089.3048181808567, 4189.868735441475, 4305.246581848227, 4033.983008495752, 4156.459660244149, 4525.79633916468, 4733.573978341966, 4903.41159060915, 4044.4337792708457, 4253.021804984809, 4302.784860757012, 4728.787204575733, 4752.881177970578, 4048.1701251242835, 4673.859784206479, 4785.114753770564, 4882.6826256293225, 4938.937588971333, 4335.853752392586, 4422.535633758409, 4682.555157260055, 4769.523047695203, 4813.4945830687275], "value": 3902.5884259952804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.5021058048272, 687.7970998555426, 711.1395211793729, 764.8355603545236, 807.6325272001241, 12741.490340386397, 14800.925995370035, 15353.923230383847, 15960.680786384266, 15987.84012159878, 14208.289585520733, 14286.0, 14295.142291462493, 14313.71372572548, 14331.426742930296, 685.9588424694509, 839.2949922065463, 868.2663149638545, 872.8821609082788, 873.7553485024204, 696.8118607975844, 832.3549249331786, 843.3169133002287, 859.1623167411786, 875.1511034296753, 870.5212133326677, 911.4576826788051, 918.0085507651753, 920.7661733277407, 923.372106967262, 920.4247345409119, 921.4379228670573, 921.6497730862296, 921.8617207418873, 921.9032001639832, 582.5834528312278, 659.2056571830932, 680.3944489404435, 680.8161796314968, 682.1779755394738, 14712.48506302285, 15129.319180636898, 15287.0, 15357.232138393147, 15373.385064597403, 14678.779818302733, 14689.192094434802, 14804.555863324118, 14956.775648365283, 14972.1016738996, 10444.26890117692, 11333.489992950255, 11639.010684091862, 11910.523579056828, 11984.58053968107, 3798.867039653599, 3835.7698538087525, 3951.9012024699323, 3997.480327557399, 4052.513698356216, 91184.0, 100450.49774751079, 101530.47704284442, 117457.2381414271, 125500.0, 10342.689719308433, 10946.56213751457, 11290.266132701348, 11341.43292835355, 11471.885281147082, 18650.626987460448, 22319.665205021938, 22567.88716056442, 22629.0, 22764.886175569016, 7669.692567785312, 8030.718924837603, 8037.115917249098, 8122.959385203036, 8205.466644668077, 4341.717788343748, 4447.6219521341045, 4474.977625111918, 4520.59314661682, 4550.431196100488, 3502.7372947029075, 3639.7816131032223, 3640.5449318835144, 3641.453781932731, 3644.890653280406, 620.4849974521137, 629.0721186250245, 648.1412128929094, 662.192125606759, 690.1063123255396, 493.58538827385166, 528.923306120618, 592.5496622566881, 603.8520562462137, 629.6788637794758, 7183.317584829538, 7468.663910124057, 7894.60526973649, 7967.808036112, 9327.0, 498.5263999200774, 501.28316507394777, 516.8061976758715, 562.8846086552247, 620.5997131849931, 4397.1865204937185, 4517.12385163156, 4555.453345598549, 4559.521250268674, 4678.087772884255, 128441.0, 153189.23405382902, 163059.0, 166332.0, 166361.0, 88047.0, 134308.0, 135299.0, 137440.0, 138708.0, 98213.50893245488, 122549.77450225741, 123013.0, 123306.38346808388, 123928.38035809764, 8667.956660216658, 9055.592498337723, 9591.856122158033, 9829.361091529028, 10008.699739007841, 54011.0, 55731.72134139304, 56492.717536412056, 57230.7138464305, 58365.12452313134, 94446.0, 94795.0, 96006.0399396025, 96780.0, 96971.0, 12644.873551264738, 13125.474981000652, 13299.268540229994, 13594.048416610742, 13761.79357309621, 12231.938840305742, 14538.273086345853, 15305.234738263265, 15589.532314030597, 16050.277737501607, 13774.035817492679, 13831.861681383058, 13942.58172254834, 15005.0, 15015.399384024953, 14071.648208794863, 14177.078489898124, 14197.0, 14336.0, 14339.283035847957, 13658.931705341409, 13727.656808579866, 13737.862621373659, 13855.653608659864, 14704.0, 10817.296875703054, 11047.447627618747, 11055.447227638426, 11060.723481913017, 12127.636170914886, 10164.593416263267, 10680.465976701289, 10832.620858269922, 11197.496112674786, 11298.943505282421], "value": 7771.144674743394, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 151.0, 174.0, 101.0, 160.0, 176.0, 176.0, 117.0, 119.0, 116.0], "value": 141.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 113.0, 98.0, 181.0, 142.0, 143.0, 112.0, 141.0, 178.0, 112.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 229.0, 224.0, 199.0, 201.0, 196.0, 199.0, 197.0, 202.0], "value": 204.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 57.0, 59.0, 82.0, 59.0, 60.0, 57.0, 56.0, 72.0, 72.0], "value": 64.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 88.0, 73.0, 69.0, 72.0, 119.0, 55.0, 80.0, 115.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 100.0, 132.0, 90.0, 85.0, 89.0, 86.0, 88.0, 87.0], "value": 93.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 149.0, 120.0, 107.0, 102.0, 97.0, 106.0, 97.0, 95.0, 118.0], "value": 109.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 88.0, 92.0, 80.0, 147.0, 136.0, 143.0, 125.0, 150.0], "value": 119.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 59.0, 88.0, 92.0, 91.0, 51.0, 60.0, 90.0, 93.0], "value": 73.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 85.0, 87.0, 74.0, 115.0, 103.0, 107.0, 107.0, 80.0, 71.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 88.0, 84.0, 86.0, 87.0, 85.0, 87.0, 83.0, 91.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 139.0, 138.0, 140.0, 146.0, 154.0, 159.0, 191.0, 156.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 165.0, 166.0, 165.0, 170.0, 165.0, 168.0, 168.0, 168.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 67.0, 69.0, 68.0, 67.0, 70.0, 68.0, 69.0], "value": 68.4, "unit": "score"}]}]} 03:32:18 INFO - Return code: 0 03:32:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:32:18 ERROR - # TBPL SUCCESS # 03:32:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:32:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:32:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:32:18 INFO - 2016-11-12 03:32:18.201 screenresolution[1684:11784] starting screenresolution argv=screenresolution get 03:32:18 INFO - 2016-11-12 03:32:18.203 screenresolution[1684:11784] Display 0: 1600x1200x32@60 03:32:18 INFO - 2016-11-12 03:32:18.209 screenresolution[1685:11787] starting screenresolution argv=screenresolution list 03:32:18 INFO - Available Modes on Display 0 03:32:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:32:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:32:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:32:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:32:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:32:18 INFO - Intel Iris: 03:32:18 INFO - Chipset Model: Intel Iris 03:32:18 INFO - Type: GPU 03:32:18 INFO - Bus: Built-In 03:32:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:32:18 INFO - Vendor: Intel (0x8086) 03:32:18 INFO - Device ID: 0x0a2e 03:32:18 INFO - Revision ID: 0x0009 03:32:18 INFO - Displays: 03:32:18 INFO - Display: 03:32:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:32:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:32:18 INFO - Display Serial Number: 1600x1200 60 03:32:18 INFO - Main Display: Yes 03:32:18 INFO - Mirror: Off 03:32:18 INFO - Online: Yes 03:32:18 INFO - Rotation: Supported 03:32:18 INFO - Return code: 0 03:32:18 INFO - Running post-action listener: _resource_record_post_action 03:32:18 INFO - [mozharness: 2016-11-12 11:32:18.446214Z] Finished run-tests step (success) 03:32:18 INFO - Running post-run listener: _resource_record_post_run 03:32:18 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 33668096; Write bytes: 671725056; Read time: 318; Write time: 2113 03:32:18 INFO - TinderboxPrint: CPU usage
54.4% 03:32:18 INFO - TinderboxPrint: I/O read bytes / time
33,668,096 / 318 03:32:18 INFO - TinderboxPrint: I/O write bytes / time
671,725,056 / 2,113 03:32:18 INFO - TinderboxPrint: CPU idle
2,203.7 (45.6%) 03:32:18 INFO - TinderboxPrint: CPU system
977.8 (20.2%) 03:32:18 INFO - TinderboxPrint: CPU user
1,656.2 (34.2%) 03:32:18 INFO - TinderboxPrint: Swap in / out
393,818,112 / 0 03:32:18 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 362975744; Write bytes: 357205504; Read time: 28533; Write time: 722 03:32:18 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31611904; Write bytes: 304222208; Read time: 296; Write time: 1359 03:32:18 INFO - Running post-run listener: _upload_blobber_files 03:32:18 INFO - Blob upload gear active. 03:32:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:32:18 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 03:32:18 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'] 03:32:18 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 03:32:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:20 INFO - (blobuploader) - INFO - Done attempting. 03:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:20 INFO - (blobuploader) - INFO - Done attempting. 03:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:23 INFO - (blobuploader) - INFO - Done attempting. 03:32:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:32:23 INFO - Return code: 0 03:32:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:32:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:32:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdd28d95cf87a10ffe130fd93c55995b05be179dbca77c97c2a5724b0fc40e08a67774abe8bb4336b17477b6feca1d32f376e57ebdcdc3f9b6832fc526544c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b62c2f6ea77dcf011037f5bddc211806003c7dea3fcd79cd627909900e17fb9eb21173bd612b26fb26785c849ac06c3a6acfc70a05971b7f994887f1960d471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94832e34c032f108c840f68e1fba85084e81f4c7244f65522183047f11e5aaa2b71327bc6b0fbdd162c7c24f3345856cd36a3af0bd94559867d5dc03d28c4678"} 03:32:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:32:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:32:23 INFO - Contents: 03:32:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdd28d95cf87a10ffe130fd93c55995b05be179dbca77c97c2a5724b0fc40e08a67774abe8bb4336b17477b6feca1d32f376e57ebdcdc3f9b6832fc526544c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b62c2f6ea77dcf011037f5bddc211806003c7dea3fcd79cd627909900e17fb9eb21173bd612b26fb26785c849ac06c3a6acfc70a05971b7f994887f1960d471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94832e34c032f108c840f68e1fba85084e81f4c7244f65522183047f11e5aaa2b71327bc6b0fbdd162c7c24f3345856cd36a3af0bd94559867d5dc03d28c4678"} 03:32:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:32:23 INFO - Copying logs to upload dir... 03:32:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:32:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.395420 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-12 03:32:23.162716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 03:32:23.166506) ========= 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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdd28d95cf87a10ffe130fd93c55995b05be179dbca77c97c2a5724b0fc40e08a67774abe8bb4336b17477b6feca1d32f376e57ebdcdc3f9b6832fc526544c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b62c2f6ea77dcf011037f5bddc211806003c7dea3fcd79cd627909900e17fb9eb21173bd612b26fb26785c849ac06c3a6acfc70a05971b7f994887f1960d471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94832e34c032f108c840f68e1fba85084e81f4c7244f65522183047f11e5aaa2b71327bc6b0fbdd162c7c24f3345856cd36a3af0bd94559867d5dc03d28c4678"} build_url:https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010650 build_url: 'https://queue.taskcluster.net/v1/task/HcfVRFVWS4eiA4YtUp7vNQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdd28d95cf87a10ffe130fd93c55995b05be179dbca77c97c2a5724b0fc40e08a67774abe8bb4336b17477b6feca1d32f376e57ebdcdc3f9b6832fc526544c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b62c2f6ea77dcf011037f5bddc211806003c7dea3fcd79cd627909900e17fb9eb21173bd612b26fb26785c849ac06c3a6acfc70a05971b7f994887f1960d471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94832e34c032f108c840f68e1fba85084e81f4c7244f65522183047f11e5aaa2b71327bc6b0fbdd162c7c24f3345856cd36a3af0bd94559867d5dc03d28c4678"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 03:32:23.202282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 03:32:23.202671) ========= 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.IrNlQZVEi0/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.FQAZcTvyQ1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.004981 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 03:32:23.253884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 03:32:23.254231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 03:32:23.254557) ========= ========= Total master_lag: 0.18 =========