builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0315 starttime: 1476351234.91 results: success (0) buildid: 20161013001024 builduid: e0ee6b336e5247f79873e28078a9afb7 revision: 2cebb2efe185a3a7593a738af84b7d70e327de77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:54.910943) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:54.911751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:54.912040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:54.990004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:54.990378) ========= 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.b54E7wp6Co/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.KJLRjvUmOl/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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-10-13 02:33:55-- 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% 18.4M=0.001s 2016-10-13 02:33:55 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122590 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:55.144204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:55.144486) ========= 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.b54E7wp6Co/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.KJLRjvUmOl/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.029010 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:55.206584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 02:33:55.206945) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2cebb2efe185a3a7593a738af84b7d70e327de77 --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 2cebb2efe185a3a7593a738af84b7d70e327de77 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b54E7wp6Co/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.KJLRjvUmOl/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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-10-13 02:33:55,293 truncating revision to first 12 chars 2016-10-13 02:33:55,294 Setting DEBUG logging. 2016-10-13 02:33:55,294 attempt 1/10 2016-10-13 02:33:55,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2cebb2efe185?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 02:33:56,269 unpacking tar archive at: mozilla-aurora-2cebb2efe185/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 02:33:56.514908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:56.515209) ========= script_repo_revision: 2cebb2efe185a3a7593a738af84b7d70e327de77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:56.515586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:56.515876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 02:33:56.533983) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-13 02:33:56.534322) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b54E7wp6Co/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.KJLRjvUmOl/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:33:56 INFO - MultiFileLogger online at 20161013 02:33:56 in /builds/slave/test 02:33:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:33:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:56 INFO - {'append_to_log': False, 02:33:56 INFO - 'base_work_dir': '/builds/slave/test', 02:33:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:33:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:56 INFO - 'branch': 'Mozilla-Aurora', 02:33:56 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:56 INFO - 'config_files': ('talos/mac_config.py',), 02:33:56 INFO - 'default_actions': ('clobber', 02:33:56 INFO - 'read-buildbot-config', 02:33:56 INFO - 'download-and-extract', 02:33:56 INFO - 'populate-webroot', 02:33:56 INFO - 'create-virtualenv', 02:33:56 INFO - 'install', 02:33:56 INFO - 'run-tests'), 02:33:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:56 INFO - 'download_minidump_stackwalk': True, 02:33:56 INFO - 'download_symbols': 'ondemand', 02:33:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:56 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:56 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:56 INFO - 'installer_path': 'installer.exe', 02:33:56 INFO - 'log_level': 'info', 02:33:56 INFO - 'log_name': 'talos', 02:33:56 INFO - 'log_to_console': True, 02:33:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:33:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:33:56 INFO - 'opt_config_files': (), 02:33:56 INFO - 'pip_index': False, 02:33:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:56 INFO - 'cmd': ('bash', 02:33:56 INFO - '-c', 02:33:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:56 INFO - 'enabled': True, 02:33:56 INFO - 'halt_on_failure': False, 02:33:56 INFO - 'name': 'check_screen_resolution'},), 02:33:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:56 INFO - 'cmd': ('bash', 02:33:56 INFO - '-c', 02:33:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:56 INFO - 'enabled': True, 02:33:56 INFO - 'halt_on_failure': False, 02:33:56 INFO - 'name': 'check_screen_resolution'},), 02:33:56 INFO - 'run_cmd_checks_enabled': True, 02:33:56 INFO - 'sps_profile': False, 02:33:56 INFO - 'sps_profile_interval': 0, 02:33:56 INFO - 'suite': 'dromaeojs', 02:33:56 INFO - 'system_bits': '32', 02:33:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:56 INFO - 'title': 't-yosemite-r7-0315', 02:33:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:56 INFO - 'use_talos_json': True, 02:33:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:56 INFO - 'work_dir': 'build'} 02:33:56 INFO - [mozharness: 2016-10-13 09:33:56.734555Z] Running clobber step. 02:33:56 INFO - Running pre-action listener: _resource_record_pre_action 02:33:56 INFO - Running main action method: clobber 02:33:56 INFO - rmtree: /builds/slave/test/build 02:33:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:59 INFO - Running post-action listener: _resource_record_post_action 02:33:59 INFO - [mozharness: 2016-10-13 09:33:59.004592Z] Finished clobber step (success) 02:33:59 INFO - [mozharness: 2016-10-13 09:33:59.004777Z] Running read-buildbot-config step. 02:33:59 INFO - Running pre-action listener: _resource_record_pre_action 02:33:59 INFO - Running main action method: read_buildbot_config 02:33:59 INFO - Using buildbot properties: 02:33:59 INFO - { 02:33:59 INFO - "project": "", 02:33:59 INFO - "product": "firefox", 02:33:59 INFO - "script_repo_revision": "production", 02:33:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:33:59 INFO - "repository": "", 02:33:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:33:59 INFO - "buildid": "20161013001024", 02:33:59 INFO - "pgo_build": "False", 02:33:59 INFO - "basedir": "/builds/slave/test", 02:33:59 INFO - "buildnumber": 3, 02:33:59 INFO - "slavename": "t-yosemite-r7-0315", 02:33:59 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:33:59 INFO - "platform": "yosemite_r7", 02:33:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:33:59 INFO - "branch": "mozilla-aurora", 02:33:59 INFO - "repo_path": "releases/mozilla-aurora", 02:33:59 INFO - "revision": "2cebb2efe185a3a7593a738af84b7d70e327de77", 02:33:59 INFO - "stage_platform": "macosx64", 02:33:59 INFO - "builduid": "e0ee6b336e5247f79873e28078a9afb7", 02:33:59 INFO - "slavebuilddir": "test" 02:33:59 INFO - } 02:33:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:33:59 INFO - Running post-action listener: _resource_record_post_action 02:33:59 INFO - [mozharness: 2016-10-13 09:33:59.010645Z] Finished read-buildbot-config step (success) 02:33:59 INFO - [mozharness: 2016-10-13 09:33:59.010850Z] Running download-and-extract step. 02:33:59 INFO - Running pre-action listener: _resource_record_pre_action 02:33:59 INFO - Running main action method: download_and_extract 02:33:59 INFO - mkdir: /builds/slave/test/build/tests 02:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:59 INFO - trying https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:33:59 INFO - Downloading https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/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 02:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/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 02:33:59 INFO - Downloaded 1199 bytes. 02:33:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:33:59 INFO - Using the following test package requirements: 02:33:59 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:33:59 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:33:59 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:33:59 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'jsshell-mac.zip'], 02:33:59 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:33:59 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:33:59 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:33:59 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:33:59 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:33:59 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:33:59 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:33:59 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:33:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:33:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:33:59 INFO - Fetch https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:34:00 INFO - Expected file size: 16435293 02:34:07 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 02:34:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:34:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:34:07 INFO - Fetch https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:34:07 INFO - Expected file size: 16435293 02:34:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:34:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:34:14 INFO - Fetch https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:34:15 INFO - Expected file size: 14414059 02:34:16 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')]} 02:34:16 INFO - trying https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:34:16 INFO - Downloading https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/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 02:34:19 INFO - Downloaded 115364880 bytes. 02:34:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:34:19 INFO - mkdir: /builds/slave/test/properties 02:34:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:34:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:34:19 INFO - Contents: 02:34:19 INFO - build_url:https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:34:20 INFO - Running post-action listener: _resource_record_post_action 02:34:20 INFO - Running post-action listener: set_extra_try_arguments 02:34:20 INFO - [mozharness: 2016-10-13 09:34:20.128487Z] Finished download-and-extract step (success) 02:34:20 INFO - [mozharness: 2016-10-13 09:34:20.128609Z] Running populate-webroot step. 02:34:20 INFO - Running pre-action listener: _resource_record_pre_action 02:34:20 INFO - Running main action method: populate_webroot 02:34:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:34:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:34:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:34:20 INFO - '--tppagecycles', 02:34:20 INFO - '7'], 02:34:20 INFO - 'tests': ['tsvgm']}}, 02:34:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:34:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:34:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:34:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:34:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['damp', 'tps']}, 02:34:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'tests': ['damp', 'tps']}, 02:34:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['dromaeo_dom']}, 02:34:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:34:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['basic_compositor_video']}, 02:34:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:34:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['a11yr', 02:34:20 INFO - 'ts_paint', 02:34:20 INFO - 'tpaint', 02:34:20 INFO - 'sessionrestore', 02:34:20 INFO - 'sessionrestore_no_auto_restore', 02:34:20 INFO - 'tabpaint']}, 02:34:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:34:20 INFO - 'ts_paint', 02:34:20 INFO - 'tpaint', 02:34:20 INFO - 'sessionrestore', 02:34:20 INFO - 'sessionrestore_no_auto_restore', 02:34:20 INFO - 'tabpaint']}, 02:34:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:34:20 INFO - 'ts_paint', 02:34:20 INFO - 'tpaint', 02:34:20 INFO - 'sessionrestore', 02:34:20 INFO - 'sessionrestore_no_auto_restore', 02:34:20 INFO - 'tabpaint']}, 02:34:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:34:20 INFO - 'ts_paint', 02:34:20 INFO - 'tpaint', 02:34:20 INFO - 'sessionrestore', 02:34:20 INFO - 'sessionrestore_no_auto_restore', 02:34:20 INFO - 'tabpaint']}, 02:34:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['a11yr', 02:34:20 INFO - 'ts_paint', 02:34:20 INFO - 'tpaint', 02:34:20 INFO - 'sessionrestore', 02:34:20 INFO - 'sessionrestore_no_auto_restore', 02:34:20 INFO - 'tabpaint']}, 02:34:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['a11yr', 02:34:20 INFO - 'ts_paint', 02:34:20 INFO - 'tpaint', 02:34:20 INFO - 'sessionrestore', 02:34:20 INFO - 'sessionrestore_no_auto_restore', 02:34:20 INFO - 'tabpaint']}, 02:34:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['tsvgx', 02:34:20 INFO - 'tsvgr_opacity', 02:34:20 INFO - 'tart', 02:34:20 INFO - 'tscrollx', 02:34:20 INFO - 'cart']}, 02:34:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:34:20 INFO - 'tsvgr_opacity', 02:34:20 INFO - 'tart', 02:34:20 INFO - 'tscrollx', 02:34:20 INFO - 'cart']}, 02:34:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'talos_options': ['--disable-e10s'], 02:34:20 INFO - 'tests': ['tp5o']}, 02:34:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'tests': ['tp5o']}, 02:34:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'talos_options': ['--disable-e10s', 02:34:20 INFO - '--xperf_path', 02:34:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:20 INFO - 'tests': ['tp5n']}, 02:34:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:20 INFO - 'talos_options': ['--xperf_path', 02:34:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:20 INFO - 'tests': ['tp5n']}}, 02:34:20 INFO - 'talos.zip': {'path': '', 02:34:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:34:20 INFO - Running post-action listener: _resource_record_post_action 02:34:20 INFO - [mozharness: 2016-10-13 09:34:20.147172Z] Finished populate-webroot step (success) 02:34:20 INFO - [mozharness: 2016-10-13 09:34:20.147280Z] Running create-virtualenv step. 02:34:20 INFO - Running pre-action listener: _resource_record_pre_action 02:34:20 INFO - Running main action method: create_virtualenv 02:34:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:34:20 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 02:34:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:34:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:34:20 INFO - Using real prefix '/tools/python27' 02:34:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:34:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:34:23 INFO - Installing pip.................done. 02:34:23 INFO - Return code: 0 02:34:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:34:23 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')]} 02:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:23 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')]} 02:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:23 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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:23 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 02:34:23 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 02:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:23 INFO - 'HOME': '/Users/cltbld', 02:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:23 INFO - 'LOGNAME': 'cltbld', 02:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:23 INFO - 'MOZ_NO_REMOTE': '1', 02:34:23 INFO - 'NO_EM_RESTART': '1', 02:34:23 INFO - 'PAGER': '/bin/cat', 02:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:23 INFO - 'PWD': '/builds/slave/test', 02:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:23 INFO - 'SHELL': '/bin/bash', 02:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:23 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:23 INFO - 'USER': 'cltbld', 02:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:23 INFO - 'XPC_FLAGS': '0x0', 02:34:23 INFO - 'XPC_SERVICE_NAME': '0', 02:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:24 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 02:34:24 INFO - Cleaning up... 02:34:24 INFO - Return code: 0 02:34:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:34:24 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')]} 02:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:24 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')]} 02:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:24 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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:24 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 02:34:24 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 02:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:24 INFO - 'HOME': '/Users/cltbld', 02:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:24 INFO - 'LOGNAME': 'cltbld', 02:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:24 INFO - 'MOZ_NO_REMOTE': '1', 02:34:24 INFO - 'NO_EM_RESTART': '1', 02:34:24 INFO - 'PAGER': '/bin/cat', 02:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:24 INFO - 'PWD': '/builds/slave/test', 02:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:24 INFO - 'SHELL': '/bin/bash', 02:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:24 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:24 INFO - 'USER': 'cltbld', 02:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:24 INFO - 'XPC_FLAGS': '0x0', 02:34:24 INFO - 'XPC_SERVICE_NAME': '0', 02:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:24 INFO - Downloading/unpacking psutil>=3.1.1 02:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:34:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:27 INFO - Installing collected packages: psutil 02:34:27 INFO - Running setup.py install for psutil 02:34:27 INFO - building 'psutil._psutil_osx' extension 02:34:27 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 02:34:28 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 02:34:28 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 02:34:28 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 02:34:28 INFO - building 'psutil._psutil_posix' extension 02:34:28 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 02:34:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:34:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:34:28 INFO - ^ 02:34:28 INFO - 1 warning generated. 02:34:28 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 02:34:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:28 INFO - Successfully installed psutil 02:34:28 INFO - Cleaning up... 02:34:28 INFO - Return code: 0 02:34:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:34:28 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')]} 02:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:28 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')]} 02:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:28 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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:28 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 02:34:28 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 02:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:28 INFO - 'HOME': '/Users/cltbld', 02:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:28 INFO - 'LOGNAME': 'cltbld', 02:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:28 INFO - 'MOZ_NO_REMOTE': '1', 02:34:28 INFO - 'NO_EM_RESTART': '1', 02:34:28 INFO - 'PAGER': '/bin/cat', 02:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:28 INFO - 'PWD': '/builds/slave/test', 02:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:28 INFO - 'SHELL': '/bin/bash', 02:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:28 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:28 INFO - 'USER': 'cltbld', 02:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:28 INFO - 'XPC_FLAGS': '0x0', 02:34:28 INFO - 'XPC_SERVICE_NAME': '0', 02:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:34:29 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 02:34:29 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 02:34:29 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 02:34:29 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 02:34:29 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 02:34:29 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 02:34:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:34:31 INFO - Installing collected packages: mozsystemmonitor 02:34:31 INFO - Running setup.py install for mozsystemmonitor 02:34:31 INFO - Successfully installed mozsystemmonitor 02:34:31 INFO - Cleaning up... 02:34:31 INFO - Return code: 0 02:34:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:34:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:31 INFO - 'HOME': '/Users/cltbld', 02:34:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:31 INFO - 'LOGNAME': 'cltbld', 02:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:31 INFO - 'MOZ_NO_REMOTE': '1', 02:34:31 INFO - 'NO_EM_RESTART': '1', 02:34:31 INFO - 'PAGER': '/bin/cat', 02:34:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:31 INFO - 'PWD': '/builds/slave/test', 02:34:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:31 INFO - 'SHELL': '/bin/bash', 02:34:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:31 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:31 INFO - 'USER': 'cltbld', 02:34:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:31 INFO - 'XPC_FLAGS': '0x0', 02:34:31 INFO - 'XPC_SERVICE_NAME': '0', 02:34:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:34:32 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 02:34:32 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 02:34:32 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 02:34:32 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 02:34:32 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 02:34:32 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 02:34:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:34:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:34:34 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 02:34:34 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 02:34:34 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 02:34:34 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 02:34:34 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 02:34:34 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 02:34:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:34:35 INFO - warning: no files found matching '*.txt' 02:34:35 INFO - no previously-included directories found matching 'build' 02:34:35 INFO - no previously-included directories found matching 'dist' 02:34:35 INFO - no previously-included directories found matching '.git*' 02:34:35 INFO - Installing collected packages: jsonschema, functools32 02:34:35 INFO - Running setup.py install for functools32 02:34:35 INFO - warning: no files found matching '*.txt' 02:34:35 INFO - no previously-included directories found matching 'build' 02:34:35 INFO - no previously-included directories found matching 'dist' 02:34:35 INFO - no previously-included directories found matching '.git*' 02:34:35 INFO - Successfully installed jsonschema functools32 02:34:35 INFO - Cleaning up... 02:34:35 INFO - Return code: 0 02:34:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:35 INFO - 'HOME': '/Users/cltbld', 02:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:35 INFO - 'LOGNAME': 'cltbld', 02:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:35 INFO - 'MOZ_NO_REMOTE': '1', 02:34:35 INFO - 'NO_EM_RESTART': '1', 02:34:35 INFO - 'PAGER': '/bin/cat', 02:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:35 INFO - 'PWD': '/builds/slave/test', 02:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:35 INFO - 'SHELL': '/bin/bash', 02:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:35 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:35 INFO - 'USER': 'cltbld', 02:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:35 INFO - 'XPC_FLAGS': '0x0', 02:34:35 INFO - 'XPC_SERVICE_NAME': '0', 02:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:34:35 INFO - Cleaning up... 02:34:35 INFO - Return code: 0 02:34:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:35 INFO - 'HOME': '/Users/cltbld', 02:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:35 INFO - 'LOGNAME': 'cltbld', 02:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:35 INFO - 'MOZ_NO_REMOTE': '1', 02:34:35 INFO - 'NO_EM_RESTART': '1', 02:34:35 INFO - 'PAGER': '/bin/cat', 02:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:35 INFO - 'PWD': '/builds/slave/test', 02:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:35 INFO - 'SHELL': '/bin/bash', 02:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:35 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:35 INFO - 'USER': 'cltbld', 02:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:35 INFO - 'XPC_FLAGS': '0x0', 02:34:35 INFO - 'XPC_SERVICE_NAME': '0', 02:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:38 INFO - Downloading blobuploader-1.2.4.tar.gz 02:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:34:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:34:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:34:39 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 02:34:39 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 02:34:39 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 02:34:39 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 02:34:39 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 02:34:39 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 02:34:39 INFO - Downloading docopt-0.6.1.tar.gz 02:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:34:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:34:39 INFO - Running setup.py install for blobuploader 02:34:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:34:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:34:40 INFO - Running setup.py install for requests 02:34:40 INFO - Running setup.py install for docopt 02:34:40 INFO - Successfully installed blobuploader requests docopt 02:34:40 INFO - Cleaning up... 02:34:40 INFO - Return code: 0 02:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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')]} 02:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:40 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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:40 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 02:34:40 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 02:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:40 INFO - 'HOME': '/Users/cltbld', 02:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:40 INFO - 'LOGNAME': 'cltbld', 02:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:40 INFO - 'MOZ_NO_REMOTE': '1', 02:34:40 INFO - 'NO_EM_RESTART': '1', 02:34:40 INFO - 'PAGER': '/bin/cat', 02:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:40 INFO - 'PWD': '/builds/slave/test', 02:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:40 INFO - 'SHELL': '/bin/bash', 02:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:40 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:40 INFO - 'USER': 'cltbld', 02:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:40 INFO - 'XPC_FLAGS': '0x0', 02:34:40 INFO - 'XPC_SERVICE_NAME': '0', 02:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-twiVnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-13tnZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-09JYd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Sk3Fm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Ia4AY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-5vhOLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-XC6qaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-BykI3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-3_oqpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-av_lSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-2VnD_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-I6gFce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-T2xIZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-0wXR8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-qzH5vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-77uhdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-DLFvEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:34:42 INFO - Running setup.py install for manifestparser 02:34:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:34:42 INFO - Running setup.py install for mozcrash 02:34:43 INFO - Running setup.py install for mozdebug 02:34:43 INFO - Running setup.py install for mozdevice 02:34:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:34:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:34:43 INFO - Running setup.py install for mozfile 02:34:43 INFO - Running setup.py install for mozhttpd 02:34:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:34:43 INFO - Running setup.py install for mozinfo 02:34:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:34:43 INFO - Running setup.py install for mozInstall 02:34:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:34:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:34:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:34:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:34:44 INFO - Running setup.py install for mozleak 02:34:44 INFO - Running setup.py install for mozlog 02:34:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:34:44 INFO - Running setup.py install for moznetwork 02:34:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:34:44 INFO - Running setup.py install for mozprocess 02:34:44 INFO - Running setup.py install for mozprofile 02:34:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:34:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:34:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:34:44 INFO - Running setup.py install for mozrunner 02:34:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:34:44 INFO - Running setup.py install for mozscreenshot 02:34:45 INFO - Running setup.py install for moztest 02:34:45 INFO - Running setup.py install for mozversion 02:34:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:34:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:34:45 INFO - Cleaning up... 02:34:45 INFO - Return code: 0 02:34:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:45 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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:45 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 02:34:45 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 02:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:45 INFO - 'HOME': '/Users/cltbld', 02:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:45 INFO - 'LOGNAME': 'cltbld', 02:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:45 INFO - 'MOZ_NO_REMOTE': '1', 02:34:45 INFO - 'NO_EM_RESTART': '1', 02:34:45 INFO - 'PAGER': '/bin/cat', 02:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:45 INFO - 'PWD': '/builds/slave/test', 02:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:45 INFO - 'SHELL': '/bin/bash', 02:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:45 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:45 INFO - 'USER': 'cltbld', 02:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:45 INFO - 'XPC_FLAGS': '0x0', 02:34:45 INFO - 'XPC_SERVICE_NAME': '0', 02:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:45 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-f1g1Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:45 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)) 02:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:45 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-OIMFkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:45 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)) 02:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:45 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Qa2kYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-J0ftTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-hrGn3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-ZexZ7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Qhzl0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-lKLax7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Juiv_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-7qZdp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-SqdXHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:46 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)) 02:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:46 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-wThtfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:47 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)) 02:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:47 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-vBppCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:47 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)) 02:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:47 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-GDlinb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:47 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)) 02:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:47 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-rsJR2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:47 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)) 02:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:47 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-gm5nLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:47 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)) 02:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:47 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-My3JKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:47 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)) 02:34:47 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)) 02:34:47 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)) 02:34:47 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)) 02:34:47 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)) 02:34:47 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)) 02:34:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:34:47 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 02:34:47 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 02:34:47 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 02:34:47 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 02:34:47 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 02:34:47 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 02:34:50 INFO - Downloading blessings-1.6.tar.gz 02:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:34:50 INFO - Installing collected packages: blessings 02:34:50 INFO - Running setup.py install for blessings 02:34:50 INFO - Successfully installed blessings 02:34:50 INFO - Cleaning up... 02:34:50 INFO - Return code: 0 02:34:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:50 INFO - Reading from file tmpfile_stdout 02:34:50 INFO - Current package versions: 02:34:50 INFO - blessings == 1.6 02:34:50 INFO - blobuploader == 1.2.4 02:34:50 INFO - docopt == 0.6.1 02:34:50 INFO - functools32 == 3.2.3-2 02:34:50 INFO - jsonschema == 2.5.1 02:34:50 INFO - manifestparser == 1.1 02:34:50 INFO - mozInstall == 1.12 02:34:50 INFO - mozcrash == 0.17 02:34:50 INFO - mozdebug == 0.1 02:34:50 INFO - mozdevice == 0.48 02:34:50 INFO - mozfile == 1.2 02:34:50 INFO - mozhttpd == 0.7 02:34:50 INFO - mozinfo == 0.9 02:34:50 INFO - mozleak == 0.1 02:34:50 INFO - mozlog == 3.4 02:34:50 INFO - moznetwork == 0.27 02:34:50 INFO - mozprocess == 0.23 02:34:50 INFO - mozprofile == 0.28 02:34:50 INFO - mozrunner == 6.12 02:34:50 INFO - mozscreenshot == 0.1 02:34:50 INFO - mozsystemmonitor == 0.3 02:34:50 INFO - moztest == 0.7 02:34:50 INFO - mozversion == 1.4 02:34:50 INFO - psutil == 3.1.1 02:34:50 INFO - requests == 1.2.3 02:34:50 INFO - wsgiref == 0.1.2 02:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:50 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')]} 02:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:50 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')]} 02:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:50 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 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:50 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 02:34:50 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 02:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:50 INFO - 'HOME': '/Users/cltbld', 02:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:50 INFO - 'LOGNAME': 'cltbld', 02:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:50 INFO - 'MOZ_NO_REMOTE': '1', 02:34:50 INFO - 'NO_EM_RESTART': '1', 02:34:50 INFO - 'PAGER': '/bin/cat', 02:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:50 INFO - 'PWD': '/builds/slave/test', 02:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:50 INFO - 'SHELL': '/bin/bash', 02:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:50 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:50 INFO - 'USER': 'cltbld', 02:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:50 INFO - 'XPC_FLAGS': '0x0', 02:34:50 INFO - 'XPC_SERVICE_NAME': '0', 02:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:34:51 INFO - Cleaning up... 02:34:51 INFO - Return code: 0 02:34:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102fa2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f18570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a94a2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, '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.b54E7wp6Co/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.KJLRjvUmOl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 02:34:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:51 INFO - 'HOME': '/Users/cltbld', 02:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:51 INFO - 'LOGNAME': 'cltbld', 02:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:51 INFO - 'MOZ_NO_REMOTE': '1', 02:34:51 INFO - 'NO_EM_RESTART': '1', 02:34:51 INFO - 'PAGER': '/bin/cat', 02:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:51 INFO - 'PWD': '/builds/slave/test', 02:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:51 INFO - 'SHELL': '/bin/bash', 02:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:34:51 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:51 INFO - 'USER': 'cltbld', 02:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:51 INFO - 'XPC_FLAGS': '0x0', 02:34:51 INFO - 'XPC_SERVICE_NAME': '0', 02:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:34:51 INFO - Cleaning up... 02:34:51 INFO - Return code: 0 02:34:51 INFO - Running post-action listener: _resource_record_post_action 02:34:51 INFO - Running post-action listener: _start_resource_monitoring 02:34:51 INFO - Starting resource monitoring. 02:34:51 INFO - [mozharness: 2016-10-13 09:34:51.336571Z] Finished create-virtualenv step (success) 02:34:51 INFO - [mozharness: 2016-10-13 09:34:51.337600Z] Running install step. 02:34:51 INFO - Running pre-action listener: _resource_record_pre_action 02:34:51 INFO - Running main action method: install 02:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:51 INFO - Reading from file tmpfile_stdout 02:34:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:34:51 INFO - Reading from file tmpfile_stdout 02:34:51 INFO - Output received: 02:34:51 INFO - Usage: mozinstall [options] installer 02:34:51 INFO - Options: 02:34:51 INFO - -h, --help show this help message and exit 02:34:51 INFO - -d DEST, --destination=DEST 02:34:51 INFO - Directory to install application into. [default: 02:34:51 INFO - "/builds/slave/test"] 02:34:51 INFO - --app=APP Application being installed. [default: firefox] 02:34:51 INFO - mkdir: /builds/slave/test/build/application 02:34:51 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'] 02:34:51 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 02:35:23 INFO - Reading from file tmpfile_stdout 02:35:23 INFO - Output received: 02:35:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:35:23 INFO - Running post-action listener: _resource_record_post_action 02:35:23 INFO - [mozharness: 2016-10-13 09:35:23.999794Z] Finished install step (success) 02:35:24 INFO - [mozharness: 2016-10-13 09:35:23.999982Z] Running run-tests step. 02:35:24 INFO - Running pre-action listener: _resource_record_pre_action 02:35:24 INFO - Running main action method: run_tests 02:35:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:35:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:35:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:35:24 INFO - 2016-10-13 02:35:24.014 screenresolution[1648:8081] starting screenresolution argv=screenresolution get 02:35:24 INFO - 2016-10-13 02:35:24.017 screenresolution[1648:8081] Display 0: 1600x1200x32@60 02:35:24 INFO - 2016-10-13 02:35:24.023 screenresolution[1649:8083] starting screenresolution argv=screenresolution list 02:35:24 INFO - Available Modes on Display 0 02:35:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:35:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:35:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:35:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:35:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:35:24 INFO - Intel Iris: 02:35:24 INFO - Chipset Model: Intel Iris 02:35:24 INFO - Type: GPU 02:35:24 INFO - Bus: Built-In 02:35:24 INFO - VRAM (Dynamic, Max): 1536 MB 02:35:24 INFO - Vendor: Intel (0x8086) 02:35:24 INFO - Device ID: 0x0a2e 02:35:24 INFO - Revision ID: 0x0009 02:35:24 INFO - Displays: 02:35:24 INFO - Display: 02:35:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:35:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:35:24 INFO - Display Serial Number: 1600x1200 60 02:35:24 INFO - Main Display: Yes 02:35:24 INFO - Mirror: Off 02:35:24 INFO - Online: Yes 02:35:24 INFO - Rotation: Supported 02:35:24 INFO - Return code: 0 02:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:35:24 INFO - Python 2.7.3 02:35:24 INFO - Return code: 0 02:35:24 INFO - grabbing minidump binary from tooltool 02:35:24 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')]} 02:35:24 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 0x102db6d30>, '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 0x102c1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102daeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:35:24 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 02:35:24 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 02:35:24 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 02:35:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:35:24 INFO - Return code: 0 02:35:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:35:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:35:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:35:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:35:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0315 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b54E7wp6Co/Render', 02:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:24 INFO - 'HOME': '/Users/cltbld', 02:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:24 INFO - 'LOGNAME': 'cltbld', 02:35:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:35:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:24 INFO - 'MOZ_NO_REMOTE': '1', 02:35:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:35:24 INFO - 'NO_EM_RESTART': '1', 02:35:24 INFO - 'PAGER': '/bin/cat', 02:35:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:24 INFO - 'PWD': '/builds/slave/test', 02:35:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:24 INFO - 'SHELL': '/bin/bash', 02:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJLRjvUmOl/Listeners', 02:35:24 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 02:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:24 INFO - 'USER': 'cltbld', 02:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:24 INFO - 'XPC_FLAGS': '0x0', 02:35:24 INFO - 'XPC_SERVICE_NAME': '0', 02:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:35:24 INFO - mozversion application_buildid: 20161013001024 02:35:24 INFO - mozversion application_changeset: 2cebb2efe185a3a7593a738af84b7d70e327de77 02:35:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:35:24 INFO - mozversion application_name: Firefox 02:35:24 INFO - mozversion application_remotingname: firefox-dev 02:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:35:24 INFO - mozversion application_vendor: Mozilla 02:35:24 INFO - mozversion application_version: 51.0a2 02:35:24 INFO - mozversion platform_buildid: 20161013001024 02:35:24 INFO - mozversion platform_changeset: 2cebb2efe185a3a7593a738af84b7d70e327de77 02:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:35:24 INFO - mozversion platform_version: 51.0a2 02:35:24 INFO - using testdate: 1476351324 02:35:24 INFO - actual date: 1476351324 02:35:24 INFO - starting webserver on 'localhost:49267' 02:35:24 INFO - SUITE-START | Running 2 tests 02:35:24 INFO - TEST-START | dromaeo_css 02:35:24 INFO - operating with platform_type : mac_ 02:35:24 INFO - Initialising browser for dromaeo_css test... 02:35:24 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpb36cUv/profile http://localhost:49267/getInfo.html) 02:35:27 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 02:35:27 INFO - PROCESS | 1659 | colorDepth:24 02:35:27 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 02:35:27 INFO - PROCESS | 1659 | __metrics 02:35:27 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:35:27 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:35:27 INFO - TEST-INFO | 1659: exit 0 02:35:27 INFO - Browser initialized. 02:35:27 INFO - Running cycle 1/1 for dromaeo_css test... 02:35:27 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpb36cUv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:39 INFO - PROCESS | 1662 | RSS: Main: 219660288 02:35:39 INFO - PROCESS | 1662 | 02:36:31 INFO - PROCESS | 1662 | 1476351391105 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] 02:38:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 02:38:44 INFO - PROCESS | 1662 | RSS: Main: 374652928 02:38:44 INFO - PROCESS | 1662 | 02:41:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 02:41:48 INFO - PROCESS | 1662 | RSS: Main: 350695424 02:41:48 INFO - PROCESS | 1662 | 02:44:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 02:44:51 INFO - PROCESS | 1662 | RSS: Main: 325304320 02:44:51 INFO - PROCESS | 1662 | 02:47:53 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 02:47:54 INFO - PROCESS | 1662 | RSS: Main: 323072000 02:47:54 INFO - PROCESS | 1662 | 02:50:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 02:50:58 INFO - PROCESS | 1662 | RSS: Main: 314785792 02:50:58 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 02:54:01 INFO - PROCESS | 1662 | RSS: Main: 359727104 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | __start_tp_report 02:54:01 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 02:54:01 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 02:54:01 INFO - PROCESS | 1662 | |i|pagename|runs| 02:54:01 INFO - PROCESS | 1662 | |0;dojo.html;2862.899798507052;3316.369889720954;3349.9665003349974;3360.8487618057184;3396.269801992571;5754.050581654027;5791.71041447928;5796.768129274829;5797.072468405056;5814.854628634281;5737.684427356494;5821.155932389801;5827.184194212814;5829.679367634779;5839.5620328475425;5233.58131349493;5255.684658920458;5259.7107159106135;5298.682079075248;5314.256004159421;5223.843284701465;5230.7123108229225;5365.463453654643;5369.704666243355;5373.24774531564;5286.920696189561;5324.733763311839;5325.520703136717;5329;5342.492463215988;5310.495502927216;5317.175837745156;5336.759845806948;5348.625596208228;5359.598030147755;5205.76263977569;5268.736563171826;5289.735513224324;5294.549963253128;5306.787728490855;5891.116332550152;5898.203742494751;5903.439173278532;5904.911426328608;5910.290765108214;6216.191895053614;6234.87530249397;6237.968810155966;6253.499720022387;6255.749770009194;6249.937500624981;6271.122042913996;6280.654563998978;6296.87406251877;6306.747730090791;5872.17789509469;5879.206307148523;5901.3508514063415;5909.438603332676;5978.701064946736;6179.536534759911;6238.344973777779;6243.8126856194385;6266.060090986389;6274.1843560336865;6186.721597528122;6199;6202.131701561785;6231.22109736283;6300.464460520815;6327.58870673414;6342.936570634234;6347;6350.968245158837;6356.523260755462;6118.649636126507;6185.443310102022;6233.158523599347;6262.12330273762;6324.367563243639;6315.778947736807;6337.207849018872;6354.491640668735;6362.141110950055;6365.745370185234;5008.073506401254;5011.57401620859;5017.247412888096;5018.573421259234;5024.045431368028;4419.756913369732;4448.421705178306;4460.241758900995;4466.553344665573;4497.415336006298;5880.794172203952;5946.8810623787285;5974.522038236931;5990.73041713124;6004.309504407049;6256.937430625636;6265.561410701207;6284.340144284875;6305.4009869062365;6307.022411526221;5704.030314846486;5740.598158128891;5958.821235362946;5977.880442391215;6013.909791353133;4717.410323709536;5432.511074003359;5444.265024221759;5497.5601951843755;5531.3915469298345;6361.236651601837;6365.713542890674;6386;6389.233292004989;6392.680365981682;6249.687515624109;6288.339724328879;6289.182406287154;6293.150424692608;6310.968445157745;6231.906521402092;6277.2153480814895;6282.371762823681;6336.7465301389275;6372.6495042773095;6242.094896239929;6293.150424692791;6298.527610429144;6300.936990630035;6324.17785687876;6137.754489820536;6313.55805093639;6316.715747791269;6317.6209427434505;6332.113504109337;6034.547408944259;6083.6349819011;6112.381899552462;6141.385861414002;6158.7228574715145;6216.347283535345;6217.067439883873;6221.2845522765465;6225.62646241227;6228.968855155696;6051.213342265477;6069.089636554552;6071.878562428815;6076.1493390924425;6086.087086936995;6094.146819445193;6112.266528016667;6121.54443000217;6164.137020817179;6212.596181248205;5996.430339117776;6070.817875463743;6077.453029227391;6101.328853825987;6131.785387511416 02:54:01 INFO - PROCESS | 1662 | |1;ext.html;460.801855202263;522.4409881426873;529.9788008479662;543.7661805423667;549.1625271461024;31985.840070799673;41193;42037.94905127373;42293.78853105738;44696.776516117374;43629.78185109078;43798.562014379844;43872;43946.34080488787;44157.77921110398;9274.072592740706;9300.441973481613;9779.706608801729;9985.20118390527;9995.350302230368;8905.866412003825;9122.543872806365;12181.51273949041;12382.31897245651;12415.751684966295;12344.197627154252;12424.93787531061;12442.564510242144;12468;12487.937560312232;8918.955405222998;12212.755744885097;12286.262824230575;12302.630921072292;12303.815442768366;8790.296776257885;11904.702382440422;12251;12251.877481225163;12516.936060434873;33258.83370583132;41224.587754122374;41236.79381603103;41297.58702412998;41367.965800854916;3243.2702641905385;3313.486409606515;3327;3617.9095522611883;3970.602939706035;30457;30902.22744431385;31177.532337014964;32055.19862003445;33038.83480582606;3208.374366998436;3250.5449237106823;3256.902292931216;3262.2333751568362;3262.559554460165;450099;451539;453712;455520;456094;34064.48903266453;63187.36812631815;63315.683421582595;63369.683151583944;63372;34976.65023349785;36207.094822629646;36281.91154265376;36355.45466818;36401.27197456036;15035.699286014218;15477.22613869302;15655.68688626244;15669.843301567067;15685;11789.233699809656;12028.27830330183;13000.414981325863;13121.606351809462;13129.01532385075;7427.740029099064;7707.537547747153;7908.485948413335;7917.841643167105;7940.801479963047;3217.420864244412;3217.790843595159;3228.273638431381;3230.2085988932863;3259.4947783093658;932.8973812880578;936.0686117313181;943.7687766497252;975.6780262513496;1020.637673625867;30092.398152036836;30851.8457407716;31041.689583104333;31054.844725776227;31809;1012.8581998520214;1044.4203467075845;1052.894710528941;1054.7890421915647;1129.5538262386476;15421.460248891235;15806.92096539533;15866.04803711781;15978.402159784162;16245.59386015359;204105;204773;204804;205044;205359;60226;60522;60930.69534652298;61037.69481152566;61171.41214408937;1224.5101959216206;1244.8506179258547;1245.0226572140825;1370.9794353084712;1376.181172202538;27523;32009;32605.85879494206;32908;33153.50269746004;57312.713436432554;58130.709346453;58138;58244.835103298545;58354.4164558349;631624;639028;639406;639957;640117;27114;27506.862465687544;27596;27645.58531621987;36606.63393366032;39989;41783.791081045616;48713.75643121762;48956;50624.98750024905;39661.46169825775;40289.395659065725;40534.797326013184;41971.16057678768;42246.78876605597;40370;40568.98577535585;41100.588994109676;41504.79247603743;41788.582114179684;32648.673513264563;38331.23337533289;38630.22739545249;39000.414993774546;39352.803235983636;28357.858210708815;35133.648663513035;35587.64412355947;36237.63762362448;36377.636223637426;26330.60504092402;26369;26460.206193814218;26829.865850670623;26951.730482695708 02:54:01 INFO - PROCESS | 1662 | |2;jquery.html;331.8788642145617;354.8527361145125;378.8238469111864;386.3837179698382;408.6751032928821;14504.274786260685;15164.090154590718;20191.09140088696;20607.1757129715;21934.670979935312;20451;20459.693104603444;20914.89542552289;21130.89434552825;21378.786212137875;5813.186153938452;6152.261728592575;6154.107654390111;6156.107364432155;6158.938410615904;4155.854545090922;4166.458360413142;4225.323948168294;6021;6837.042814006043;6843.589384636913;6850.623215723133;6857.07429497019;6864.931350686479;6875.381215690587;6590.242122155942;6683.42688065096;6778.728850845961;6804.387605115514;6818.4886133539685;5240.816571419982;5650.124230744241;5900.409959004108;5903.203067585864;5912.231409916726;26321.73678263212;26322.6051609226;26427.867860660765;26606.6009009865;26695.866520667467;2065.1120018392085;2134.231676596424;2155.3964889830872;2176.7279090113734;2340.742518322983;10207.693769186937;10244.53899574521;10506.684799456028;10517.1060459861;11171.329720216812;1850.6206227723285;1863.1988245054622;1887.2639670528367;1911.5603411215498;1968.7342208801772;113099.86900130975;115148;124097;129156;133417.99999999904;11496;11592.43502127202;11723.179377443668;11759.764804703858;11873.525058997717;12845.229286242855;13343.532976345781;13357.065005449525;13441.39513721885;14146.080504767364;8467.915320846836;8502.574871256536;8610.569471526398;8756.299496040301;8791.51646659427;8597.054324024351;8627.827443451095;8694.17405346491;8797.252233560219;8817;4476.2837945928495;4542.432195975503;4569.680122391467;4582.518835522289;4666.65000124992;1651.7274649682668;1853.1604247738214;1919.2610844824842;1920.875143115693;1954.2933037742828;843.8818565400849;896.9551522423983;900.5632268349846;932.5383934952107;949.4588084791741;20884;21836.45408864791;21843.344699659036;21892.9053547322;21895;924.568385147059;927.9814403711888;931.5481991234382;932.5616960028775;974.605284859633;10708.892911070945;11366.715832104264;11399.316041037398;11421;11462.312261264351;526804;602748;613443;613452;625095;72551.2744872555;77170;78464;118996;142224.288878557;949.4303417949313;981.1464026297167;985.7486340983147;1000.9049140331657;1002.9097381235578;19189.80810191936;19359.51601209981;20030.198792048737;20056.398308050782;20120.89939550293;57675.42324576701;58279.70860145842;58729;59275;59293;87046.56476717576;89576.552117239;89845.55077224573;89883;91999.54000230224;7728.149903510722;8018.959905200437;8090;8175.427720059539;8394.790130246549;11939.104567157325;13065.804012939623;13194;13228.801567976681;13461.326933653083;11185.150165468098;11682.415879205835;11704.414779260833;11726.41367931617;11781.941090294493;10987.956144166292;11269.211155219056;11382.032527235278;11459.942700286778;11733.237339572901;11483.540658373571;11511.19421640477;11560.30638161713;11685.76628467409;11952.983996360406;8090.959545202471;8199.426040177368;8229.753107406787;8370.455920365157;8444.619992100248;10372.792544148924;11129.554817807197;11168.832467512831;11306.208565400342;11537.423128843357 02:54:01 INFO - PROCESS | 1662 | |3;mootools.html;1345.5694177863088;1524.420720126352;1535.593067837023;1727.127800460768;1906.132709617125;7844.1763614820475;8374.120717324677;8714.259287960514;8890.155435233659;8939.463632182074;7822.726204582841;8722.778810966454;8804;8878.866816997734;8883.333749968762;2339.7660233976635;2376.310869847742;2378.2389635316704;2378.702662167229;2381.559411508868;2326.406766274606;2363.243761996162;2371.1463873005705;2374.7387787343378;2377.132346693453;2037.8981050947468;2310.1798861404213;2327.394877331889;2358.575456417844;2368.7275963264187;2296.024189719379;2331.207389487574;2333.9183128590503;2340.6137987232087;2344.39045848079;2322.6516022596575;2328.0571368595747;2334.6264597664294;2335.1243283768586;2340.73081595617;8763.605637746317;8843.425177363515;8886.155815197546;8893.199612034883;8895.688650897187;5269.552088072518;5414.620976531644;5432.185172224198;5437.782488700447;5448.945510544883;3566.8038257895805;3571.8035508047046;3606.278744251134;3663.102539877747;3686.1153323202507;1079.3685693869018;1080.9135269178446;1085.7557049663842;1095.1348434736549;1104.0174244922025;9959.850602240973;11721.062315014779;11849;11853.525858965631;11880.108991825648;4744.018014005408;4786.114568804782;4800.207965685623;4903.509649035068;4922.8769280768265;8793.604287807064;10240.897591024144;10242.487875606339;10262.281640285108;10274;5502.889942201214;5506.146547285177;5508.669479831223;5515.7242137892945;5518.668879867221;4016.4176194451643;4496.258117410656;4648.325992731103;4905;5049.091163590516;4004.6395824375945;4089.672826173899;4098.836046558164;4148.522919864255;4155.314373128461;1043.0664555223034;1178.4461303187488;1192.9582464613698;1227.3924407418385;1269.968250793719;826.5082276045744;887.9955600222087;900.8513595256709;919.9034101419388;920.5673333533229;5436;5816.563757718188;5859.648421094748;5926.970365148233;6020.187274717945;933.6685476655825;946.7822400847843;956.5073986896754;959.5490119643756;1019.6278358399279;3813.828377723009;3915.47141135943;3977.602239776057;4026.295398305285;4026.5369482509886;10173.54219060144;10637.680869573926;10797.406142662072;10804.13566914645;10804.837927431096;10209.438480883475;10601.310914790514;10635.734106647242;10770.299930504649;10791.56833726642;8020.438569300093;8338.24955753985;8350.624221909908;8357.791055223668;8373.832523349622;5788.768449262151;5844.12338149281;5911.467967882912;6075.817725468243;6090.3605121461605;9679.66121185755;10160.33957792741;10283.125934295369;10303.896961030294;10336.844947325646;7934.642941067781;9417.811643766949;10482.423466709099;10497.42264175447;10497.842532361869;6974.37230649244;7384.076990376203;7533.623318834146;7629.847403052019;7729;8300.916990830014;8313.6674533018;8318.168183181633;8412.789680258042;8430.494170349799;7519.548827070394;7539.095308563007;7545.132309784225;7587.848243034998;7623.9618801905635;7391.704331826882;7408.333250007309;7458.216887226763;7509.1739908608915;7563.924360756542;6822.965885170543;6905.930940690529;6931.480138989495;6964.199117101395;6974.476914231352;4814.229723244264;4833.3958255218095;4859.829905953275;4974.7512624369365;5128.8461346159675;4918.081531919989;4946.233333833262;4974.676646017997;5058.519440653132;5093.643444958965 02:54:01 INFO - PROCESS | 1662 | |4;prototype.html;299.64043148222123;302.3514561266084;310.16565438969167;314.2066282636342;317.0678206074142;5425.891482170359;5438.8912221755545;5482.396936337;5490.725463726808;5538.6122971391915;5092.79628814847;5212.635115541913;5218.39988401334;5257.737113144337;5442.9727851360785;3449.6722811332884;4017.372963949605;4145.398917157003;4150.6172469437315;4155.293600087993;3438.0403170192876;4106.589341065885;4147.315692910666;4190.203861266365;4218.4516012918275;3840.3087444260022;4078.959865234361;4150.958490415087;4158.313878210091;4195.559466256045;3258.902232933016;3453.2920751246183;3925.7612469712603;4136.172765446892;4153.231652144363;3560.394732895414;3570.214552798406;3575.7496975211748;3577.463380492921;3585.31878943;4725.589949125936;5285.7357132143625;5338.679679219259;5380.24676545284;5390.110631745757;4004.2992476316817;4316.309390497506;4474.977625111854;4702.506236845151;4716.38686970695;5272.472752724735;5463.262459567987;5658.8019419320535;5720.914186287209;5760.8271751847515;3372.4266874631126;3845.6923446124524;3866.420036994445;3885.436611691317;3893.53277606689;4848.854534363974;5035;6072.7570897164505;6075.362086980847;6114.480269177126;3368.882089126869;3912.8239229234755;3947.6972599042247;3961.7821019844187;3974.5627980922077;3549.8225088745976;3970.68234541236;3988.1624858779983;4020.6783457323927;4023.879283621496;3936.645701886844;4507.706999045052;4596.264597664424;4640.883977900579;4683.601893838993;5745.942540574624;5754.9424505754405;5764.682942438206;5784.863822367028;5792.681402522901;1126.5043380912373;1281.2248589603341;1345.4080204709896;1351.3108314759543;1361.3873756809476;859.7377799771004;875.8919966242709;879.147227189625;908.977275568116;911.0707078779608;5286.312779338661;5307.28351672527;5329;5329.973350133225;5338.572914166857;5509.669419834822;5700.344460387026;5826.126081087786;5833.620814647034;5841.795537156179;4143.875683729493;4639.373684552542;5289.312389389432;5291.7354132294;5292.92060619091;2870.3254735137225;3014.5930299409297;3032.818030918152;3032.999110293598;3054.037978036911;5727.885442291131;5956.195913551615;5970.910436343458;5992.202339298193;6121.541773428986;5246.921296180561;5989.9101513477335;6085.908711369333;6127;6155.199824022849;4985.077760614226;5304.628675992721;6199.969000154971;6216.44052035319;6252.187215661935;4856.635752318661;5564.4991950724625;5896.705164741831;5902.911456328073;5910.704464776658;4816.686915350491;5584.910942366362;5789.884202315846;5806.2451881255165;5829.6793676346515;5248;5634.943650563606;5734.967705812994;5784.913226301524;5921;3957.2085582882964;3962.980185099171;3995.5604883462215;3996.540397854284;4031.496062992126;6008.609440386361;6013.729382177725;6067.817965460867;6072.908906366496;6077.939220607737;5106.821261255986;5185.585153187661;5540.418256083214;5680.103147394776;5917.408259174221;4827.138289368561;5772.787714579985;5806.390329015392;5807.883842323215;5808.5062769665055;4444.955550444454;4834.817882531655;5297.337832770903;5659.660420374791;5720.17057526648;5095.87260318495;5581.358143813513;5682.334893993434;5748.568857335633;5759.568032397503;4955.975220123876;5072.51811077947;5362.436944120967;5597.921143371048;5670 02:54:01 INFO - PROCESS | 1662 | |5;yui.html;694.6249025526216;708.4084789201017;712.7505373119405;733.7945375294919;781.2304879693501;14762.926185369084;16008.199590020511;16011.839881601181;16033.038017718945;16111.274992625331;14040.227787471686;14139.787903181461;14183.361748721307;14201.14793112414;14219.786703199461;662.9602223866559;678.9219239787413;685.0785693242581;819.512390127873;828.9544075075884;845.5011543189516;845.7547311279721;860.2386887604453;861.2937391339104;861.8577934640776;880.9559522023906;881.8280435315116;918.7197904639082;920.7928216151379;925.2459245714721;702.7294491620712;723.5043994863536;914.8810654614924;915.5971372596036;916.3493919317259;639.4660458517144;655.7213184396612;659.8581305019444;660.0824853453703;660.5904339309611;15127.924360378238;15201.543953681406;15215.467458638894;15235.238238088052;15255.313510891925;13308.735670111324;13825.377857996315;14034.578962631138;14047.578572642837;14142.717145657132;11669.883301166965;12153.93923030388;12616.369181540886;12662;12963.935180324132;4533.886652833706;4554.203014472454;4600.102979918917;4734.100520901018;4755.38180036593;122939.38530307381;125021.37489312496;125222;127131.09303360457;127829;10119.24105692076;10289.845652315222;10671.35971841692;10758.838617420744;11207.60773372928;21085.156593736385;21151;21307.68038479424;21474.355769326947;21549.922503874743;7205.92794072063;7608.581528015901;7620.3522700571075;7737.767866964;7835.804104897309;4229.936550951738;4274.529801721808;4356.520782713899;4389.209942210433;4464.2633965396;3509.982450087733;3623.3840247158046;3630.0743310455664;3637.7089832813313;3656.2504686539196;682.7815099168218;697.9461013868993;723.9529430586995;731.2833423245249;733.9633018349061;589.3134498309507;598.9131575921467;668.9632070236087;669;672.6972862212024;8564.828703425897;9096.90903090974;9258.444493330422;9543.665971690958;9647.517624118906;642.2100815996257;665.6779051483421;674.6222115615271;678.633537889544;688.0436193690774;4008.358662614026;4504.369388285642;4697.4832768395445;4701.27130294798;4741.976290118596;78561.60719196367;131330.03004954933;162491;163602;177955.11022444806;115768.8423115758;116034.8396516041;117431.8256817438;147445;148300;79719.80420293585;86658.56670716606;93227;103752.44371334436;111750.44124779486;8534.231919127309;9519.810023747032;9524;9916.504174791376;10023.799524009624;54056;56342.718286409945;58695.30437564899;58920.41079589149;59200.519986998945;89711;90013;92381.53809230911;93310;95714.52142739242;12740.108192426442;12853.93573032129;13002.934985325013;13127.671808204872;13228.206307621573;12040;13586.93206533961;13776.380062896993;14382;14960.251987400805;13942.58172254834;14193.432262709375;14416.279186040865;14475.710485790436;14546.563603091925;13097.934510327388;13236.272005039815;13549.661258468223;14632.561023169323;14652.26738663084;12772.169808962388;13333.266670333225;13563.118397304144;13720.794188087386;13796.931015344859;9800.41197528122;10392.58429662805;10653.89346106529;11120.555177792798;11528.538858445569;11046.613368532062;11086.445677716243;11114.777704446027;11254.381009044253;11359.943200283946 02:54:01 INFO - PROCESS | 1662 | __end_tp_report 02:54:01 INFO - PROCESS | 1662 | __start_cc_report 02:54:01 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1496 02:54:01 INFO - PROCESS | 1662 | __end_cc_report 02:54:01 INFO - PROCESS | 1662 | __startTimestamp1476352441808__endTimestamp 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | ------- Summary: start ------- 02:54:01 INFO - PROCESS | 1662 | Number of tests: 6 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5823.11 Median:6077.45 stddev:658.26 (10.8%) stddev-sans-first:617.96 02:54:01 INFO - PROCESS | 1662 | Values: 2862.9 3316.4 3350.0 3360.8 3396.3 5754.1 5791.7 5796.8 5797.1 5814.9 5737.7 5821.2 5827.2 5829.7 5839.6 5233.6 5255.7 5259.7 5298.7 5314.3 5223.8 5230.7 5365.5 5369.7 5373.2 5286.9 5324.7 5325.5 5329.0 5342.5 5310.5 5317.2 5336.8 5348.6 5359.6 5205.8 5268.7 5289.7 5294.5 5306.8 5891.1 5898.2 5903.4 5904.9 5910.3 6216.2 6234.9 6238.0 6253.5 6255.7 6249.9 6271.1 6280.7 6296.9 6306.7 5872.2 5879.2 5901.4 5909.4 5978.7 6179.5 6238.3 6243.8 6266.1 6274.2 6186.7 6199.0 6202.1 6231.2 6300.5 6327.6 6342.9 6347.0 6351.0 6356.5 6118.6 6185.4 6233.2 6262.1 6324.4 6315.8 6337.2 6354.5 6362.1 6365.7 5008.1 5011.6 5017.2 5018.6 5024.0 4419.8 4448.4 4460.2 4466.6 4497.4 5880.8 5946.9 5974.5 5990.7 6004.3 6256.9 6265.6 6284.3 6305.4 6307.0 5704.0 5740.6 5958.8 5977.9 6013.9 4717.4 5432.5 5444.3 5497.6 5531.4 6361.2 6365.7 6386.0 6389.2 6392.7 6249.7 6288.3 6289.2 6293.2 6311.0 6231.9 6277.2 6282.4 6336.7 6372.6 6242.1 6293.2 6298.5 6300.9 6324.2 6137.8 6313.6 6316.7 6317.6 6332.1 6034.5 6083.6 6112.4 6141.4 6158.7 6216.3 6217.1 6221.3 6225.6 6229.0 6051.2 6069.1 6071.9 6076.1 6086.1 6094.1 6112.3 6121.5 6164.1 6212.6 5996.4 6070.8 6077.5 6101.3 6131.8 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:58454.06 Median:35360.65 stddev:125360.34 (354.5%) stddev-sans-first:125636.39 02:54:01 INFO - PROCESS | 1662 | Values: 460.8 522.4 530.0 543.8 549.2 31985.8 41193.0 42037.9 42293.8 44696.8 43629.8 43798.6 43872.0 43946.3 44157.8 9274.1 9300.4 9779.7 9985.2 9995.4 8905.9 9122.5 12181.5 12382.3 12415.8 12344.2 12424.9 12442.6 12468.0 12487.9 8919.0 12212.8 12286.3 12302.6 12303.8 8790.3 11904.7 12251.0 12251.9 12516.9 33258.8 41224.6 41236.8 41297.6 41368.0 3243.3 3313.5 3327.0 3617.9 3970.6 30457.0 30902.2 31177.5 32055.2 33038.8 3208.4 3250.5 3256.9 3262.2 3262.6 450099.0 451539.0 453712.0 455520.0 456094.0 34064.5 63187.4 63315.7 63369.7 63372.0 34976.7 36207.1 36281.9 36355.5 36401.3 15035.7 15477.2 15655.7 15669.8 15685.0 11789.2 12028.3 13000.4 13121.6 13129.0 7427.7 7707.5 7908.5 7917.8 7940.8 3217.4 3217.8 3228.3 3230.2 3259.5 932.9 936.1 943.8 975.7 1020.6 30092.4 30851.8 31041.7 31054.8 31809.0 1012.9 1044.4 1052.9 1054.8 1129.6 15421.5 15806.9 15866.0 15978.4 16245.6 204105.0 204773.0 204804.0 205044.0 205359.0 60226.0 60522.0 60930.7 61037.7 61171.4 1224.5 1244.9 1245.0 1371.0 1376.2 27523.0 32009.0 32605.9 32908.0 33153.5 57312.7 58130.7 58138.0 58244.8 58354.4 631624.0 639028.0 639406.0 639957.0 640117.0 27114.0 27506.9 27596.0 27645.6 36606.6 39989.0 41783.8 48713.8 48956.0 50625.0 39661.5 40289.4 40534.8 41971.2 42246.8 40370.0 40569.0 41100.6 41504.8 41788.6 32648.7 38331.2 38630.2 39000.4 39352.8 28357.9 35133.6 35587.6 36237.6 36377.6 26330.6 26369.0 26460.2 26829.9 26951.7 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34894.93 Median:26375.24 stddev:99458.25 (377.1%) stddev-sans-first:99703.40 02:54:01 INFO - PROCESS | 1662 | Values: 331.9 354.9 378.8 386.4 408.7 14504.3 15164.1 20191.1 20607.2 21934.7 20451.0 20459.7 20914.9 21130.9 21378.8 5813.2 6152.3 6154.1 6156.1 6158.9 4155.9 4166.5 4225.3 6021.0 6837.0 6843.6 6850.6 6857.1 6864.9 6875.4 6590.2 6683.4 6778.7 6804.4 6818.5 5240.8 5650.1 5900.4 5903.2 5912.2 26321.7 26322.6 26427.9 26606.6 26695.9 2065.1 2134.2 2155.4 2176.7 2340.7 10207.7 10244.5 10506.7 10517.1 11171.3 1850.6 1863.2 1887.3 1911.6 1968.7 113099.9 115148.0 124097.0 129156.0 133418.0 11496.0 11592.4 11723.2 11759.8 11873.5 12845.2 13343.5 13357.1 13441.4 14146.1 8467.9 8502.6 8610.6 8756.3 8791.5 8597.1 8627.8 8694.2 8797.3 8817.0 4476.3 4542.4 4569.7 4582.5 4666.7 1651.7 1853.2 1919.3 1920.9 1954.3 843.9 897.0 900.6 932.5 949.5 20884.0 21836.5 21843.3 21892.9 21895.0 924.6 928.0 931.5 932.6 974.6 10708.9 11366.7 11399.3 11421.0 11462.3 526804.0 602748.0 613443.0 613452.0 625095.0 72551.3 77170.0 78464.0 118996.0 142224.3 949.4 981.1 985.7 1000.9 1002.9 19189.8 19359.5 20030.2 20056.4 20120.9 57675.4 58279.7 58729.0 59275.0 59293.0 87046.6 89576.6 89845.6 89883.0 91999.5 7728.1 8019.0 8090.0 8175.4 8394.8 11939.1 13065.8 13194.0 13228.8 13461.3 11185.2 11682.4 11704.4 11726.4 11781.9 10988.0 11269.2 11382.0 11459.9 11733.2 11483.5 11511.2 11560.3 11685.8 11953.0 8091.0 8199.4 8229.8 8370.5 8444.6 10372.8 11129.6 11168.8 11306.2 11537.4 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5715.90 Median:4904.25 stddev:3189.34 (65.0%) stddev-sans-first:3181.37 02:54:01 INFO - PROCESS | 1662 | Values: 1345.6 1524.4 1535.6 1727.1 1906.1 7844.2 8374.1 8714.3 8890.2 8939.5 7822.7 8722.8 8804.0 8878.9 8883.3 2339.8 2376.3 2378.2 2378.7 2381.6 2326.4 2363.2 2371.1 2374.7 2377.1 2037.9 2310.2 2327.4 2358.6 2368.7 2296.0 2331.2 2333.9 2340.6 2344.4 2322.7 2328.1 2334.6 2335.1 2340.7 8763.6 8843.4 8886.2 8893.2 8895.7 5269.6 5414.6 5432.2 5437.8 5448.9 3566.8 3571.8 3606.3 3663.1 3686.1 1079.4 1080.9 1085.8 1095.1 1104.0 9959.9 11721.1 11849.0 11853.5 11880.1 4744.0 4786.1 4800.2 4903.5 4922.9 8793.6 10240.9 10242.5 10262.3 10274.0 5502.9 5506.1 5508.7 5515.7 5518.7 4016.4 4496.3 4648.3 4905.0 5049.1 4004.6 4089.7 4098.8 4148.5 4155.3 1043.1 1178.4 1193.0 1227.4 1270.0 826.5 888.0 900.9 919.9 920.6 5436.0 5816.6 5859.6 5927.0 6020.2 933.7 946.8 956.5 959.5 1019.6 3813.8 3915.5 3977.6 4026.3 4026.5 10173.5 10637.7 10797.4 10804.1 10804.8 10209.4 10601.3 10635.7 10770.3 10791.6 8020.4 8338.2 8350.6 8357.8 8373.8 5788.8 5844.1 5911.5 6075.8 6090.4 9679.7 10160.3 10283.1 10303.9 10336.8 7934.6 9417.8 10482.4 10497.4 10497.8 6974.4 7384.1 7533.6 7629.8 7729.0 8300.9 8313.7 8318.2 8412.8 8430.5 7519.5 7539.1 7545.1 7587.8 7624.0 7391.7 7408.3 7458.2 7509.2 7563.9 6823.0 6905.9 6931.5 6964.2 6974.5 4814.2 4833.4 4859.8 4974.8 5128.8 4918.1 4946.2 4974.7 5058.5 5093.6 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4611.85 Median:5252.87 stddev:1437.15 (27.4%) stddev-sans-first:1404.26 02:54:01 INFO - PROCESS | 1662 | Values: 299.6 302.4 310.2 314.2 317.1 5425.9 5438.9 5482.4 5490.7 5538.6 5092.8 5212.6 5218.4 5257.7 5443.0 3449.7 4017.4 4145.4 4150.6 4155.3 3438.0 4106.6 4147.3 4190.2 4218.5 3840.3 4079.0 4151.0 4158.3 4195.6 3258.9 3453.3 3925.8 4136.2 4153.2 3560.4 3570.2 3575.7 3577.5 3585.3 4725.6 5285.7 5338.7 5380.2 5390.1 4004.3 4316.3 4475.0 4702.5 4716.4 5272.5 5463.3 5658.8 5720.9 5760.8 3372.4 3845.7 3866.4 3885.4 3893.5 4848.9 5035.0 6072.8 6075.4 6114.5 3368.9 3912.8 3947.7 3961.8 3974.6 3549.8 3970.7 3988.2 4020.7 4023.9 3936.6 4507.7 4596.3 4640.9 4683.6 5745.9 5754.9 5764.7 5784.9 5792.7 1126.5 1281.2 1345.4 1351.3 1361.4 859.7 875.9 879.1 909.0 911.1 5286.3 5307.3 5329.0 5330.0 5338.6 5509.7 5700.3 5826.1 5833.6 5841.8 4143.9 4639.4 5289.3 5291.7 5292.9 2870.3 3014.6 3032.8 3033.0 3054.0 5727.9 5956.2 5970.9 5992.2 6121.5 5246.9 5989.9 6085.9 6127.0 6155.2 4985.1 5304.6 6200.0 6216.4 6252.2 4856.6 5564.5 5896.7 5902.9 5910.7 4816.7 5584.9 5789.9 5806.2 5829.7 5248.0 5634.9 5735.0 5784.9 5921.0 3957.2 3963.0 3995.6 3996.5 4031.5 6008.6 6013.7 6067.8 6072.9 6077.9 5106.8 5185.6 5540.4 5680.1 5917.4 4827.1 5772.8 5806.4 5807.9 5808.5 4445.0 4834.8 5297.3 5659.7 5720.2 5095.9 5581.4 5682.3 5748.6 5759.6 4956.0 5072.5 5362.4 5597.9 5670.0 02:54:01 INFO - PROCESS | 1662 | 02:54:01 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:24606.70 Median:3832.30 stddev:39753.68 (1037.3%) stddev-sans-first:39824.65 02:54:01 INFO - PROCESS | 1662 | Values: 694.6 708.4 712.8 733.8 781.2 14762.9 16008.2 16011.8 16033.0 16111.3 14040.2 14139.8 14183.4 14201.1 14219.8 663.0 678.9 685.1 819.5 829.0 845.5 845.8 860.2 861.3 861.9 881.0 881.8 918.7 920.8 925.2 702.7 723.5 914.9 915.6 916.3 639.5 655.7 659.9 660.1 660.6 15127.9 15201.5 15215.5 15235.2 15255.3 13308.7 13825.4 14034.6 14047.6 14142.7 11669.9 12153.9 12616.4 12662.0 12963.9 4533.9 4554.2 4600.1 4734.1 4755.4 122939.4 125021.4 125222.0 127131.1 127829.0 10119.2 10289.8 10671.4 10758.8 11207.6 21085.2 21151.0 21307.7 21474.4 21549.9 7205.9 7608.6 7620.4 7737.8 7835.8 4229.9 4274.5 4356.5 4389.2 4464.3 3510.0 3623.4 3630.1 3637.7 3656.3 682.8 697.9 724.0 731.3 734.0 589.3 598.9 669.0 669.0 672.7 8564.8 9096.9 9258.4 9543.7 9647.5 642.2 665.7 674.6 678.6 688.0 4008.4 4504.4 4697.5 4701.3 4742.0 78561.6 131330.0 162491.0 163602.0 177955.1 115768.8 116034.8 117431.8 147445.0 148300.0 79719.8 86658.6 93227.0 103752.4 111750.4 8534.2 9519.8 9524.0 9916.5 10023.8 54056.0 56342.7 58695.3 58920.4 59200.5 89711.0 90013.0 92381.5 93310.0 95714.5 12740.1 12853.9 13002.9 13127.7 13228.2 12040.0 13586.9 13776.4 14382.0 14960.3 13942.6 14193.4 14416.3 14475.7 14546.6 13097.9 13236.3 13549.7 14632.6 14652.3 12772.2 13333.3 13563.1 13720.8 13796.9 9800.4 10392.6 10653.9 11120.6 11528.5 11046.6 11086.4 11114.8 11254.4 11359.9 02:54:01 INFO - PROCESS | 1662 | -------- Summary: end -------- 02:54:01 INFO - PROCESS | 1662 | 02:54:02 INFO - TEST-INFO | 1662: exit 0 02:54:02 INFO - TEST-OK | dromaeo_css | took 1117818ms 02:54:02 INFO - TEST-START | kraken 02:54:02 INFO - operating with platform_type : mac_ 02:54:02 INFO - Initialising browser for kraken test... 02:54:02 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpsbteIf/profile http://localhost:49267/getInfo.html) 02:54:04 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 02:54:04 INFO - PROCESS | 1667 | colorDepth:24 02:54:04 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 02:54:04 INFO - PROCESS | 1667 | __metrics 02:54:04 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:54:04 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:05 INFO - TEST-INFO | 1667: exit 0 02:54:05 INFO - Browser initialized. 02:54:05 INFO - Running cycle 1/1 for kraken test... 02:54:05 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpsbteIf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:17 INFO - PROCESS | 1668 | RSS: Main: 219324416 02:54:17 INFO - PROCESS | 1668 | 02:54:20 INFO - PROCESS | 1668 | 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) 02:54:21 INFO - PROCESS | 1668 | RSS: Main: 269635584 02:54:21 INFO - PROCESS | 1668 | 02:54:24 INFO - PROCESS | 1668 | 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) 02:54:24 INFO - PROCESS | 1668 | RSS: Main: 280104960 02:54:24 INFO - PROCESS | 1668 | 02:54:27 INFO - PROCESS | 1668 | 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) 02:54:28 INFO - PROCESS | 1668 | RSS: Main: 377757696 02:54:28 INFO - PROCESS | 1668 | 02:54:30 INFO - PROCESS | 1668 | 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) 02:54:31 INFO - PROCESS | 1668 | RSS: Main: 280592384 02:54:31 INFO - PROCESS | 1668 | 02:54:33 INFO - PROCESS | 1668 | 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) 02:54:33 INFO - PROCESS | 1668 | RSS: Main: 280997888 02:54:33 INFO - PROCESS | 1668 | 02:54:36 INFO - PROCESS | 1668 | 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) 02:54:37 INFO - PROCESS | 1668 | RSS: Main: 320421888 02:54:37 INFO - PROCESS | 1668 | 02:54:40 INFO - PROCESS | 1668 | 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) 02:54:40 INFO - PROCESS | 1668 | RSS: Main: 319733760 02:54:40 INFO - PROCESS | 1668 | 02:54:43 INFO - PROCESS | 1668 | 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) 02:54:44 INFO - PROCESS | 1668 | RSS: Main: 317460480 02:54:44 INFO - PROCESS | 1668 | 02:54:45 INFO - PROCESS | 1668 | 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) 02:54:46 INFO - PROCESS | 1668 | RSS: Main: 290062336 02:54:46 INFO - PROCESS | 1668 | 02:54:48 INFO - PROCESS | 1668 | 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) 02:54:48 INFO - PROCESS | 1668 | RSS: Main: 295493632 02:54:48 INFO - PROCESS | 1668 | 02:54:51 INFO - PROCESS | 1668 | 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) 02:54:51 INFO - PROCESS | 1668 | RSS: Main: 300011520 02:54:51 INFO - PROCESS | 1668 | 02:54:54 INFO - PROCESS | 1668 | 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) 02:54:55 INFO - PROCESS | 1668 | RSS: Main: 308969472 02:54:55 INFO - PROCESS | 1668 | 02:54:58 INFO - PROCESS | 1668 | 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) 02:54:58 INFO - PROCESS | 1668 | RSS: Main: 308764672 02:54:58 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | 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) 02:55:00 INFO - PROCESS | 1668 | RSS: Main: 352841728 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | __start_tp_report 02:55:00 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 02:55:00 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 02:55:00 INFO - PROCESS | 1668 | |i|pagename|runs| 02:55:00 INFO - PROCESS | 1668 | |0;ai-astar;116;115;118;114;113;115;113;113;114;114 02:55:00 INFO - PROCESS | 1668 | |1;audio-beat-detection;142;109;109;143;111;108;132;109;122;135 02:55:00 INFO - PROCESS | 1668 | |2;audio-dft;182;184;183;183;183;183;184;184;181;183 02:55:00 INFO - PROCESS | 1668 | |3;audio-fft;91;59;60;89;60;62;58;58;82;57 02:55:00 INFO - PROCESS | 1668 | |4;audio-oscillator;92;97;129;69;67;69;93;68;68;90 02:55:00 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;89;86;90;87;88;85;90;87;89;85 02:55:00 INFO - PROCESS | 1668 | |6;imaging-darkroom;96;113;161;97;96;96;96;97;106;141 02:55:00 INFO - PROCESS | 1668 | |7;imaging-desaturate;85;85;85;84;85;86;84;86;85;90 02:55:00 INFO - PROCESS | 1668 | |8;json-parse-financial;57;54;55;53;55;58;59;58;57;57 02:55:00 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;67;73;80;73;74;69;69;69;69;71 02:55:00 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;82;82;82;86;82;81;85;90;103;81 02:55:00 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;142;146;149;133;136;140;142;141;168;124 02:55:00 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;162;161;164;164;160;165;164;169;163;164 02:55:00 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;67;67;66;67;67;69;66;66;73;77 02:55:00 INFO - PROCESS | 1668 | __end_tp_report 02:55:00 INFO - PROCESS | 1668 | __start_cc_report 02:55:00 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2064 02:55:00 INFO - PROCESS | 1668 | __end_cc_report 02:55:00 INFO - PROCESS | 1668 | __startTimestamp1476352500779__endTimestamp 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | ------- Summary: start ------- 02:55:00 INFO - PROCESS | 1668 | Number of tests: 14 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.50 stddev:1.58 (1.4%) stddev-sans-first:1.58 02:55:00 INFO - PROCESS | 1668 | Values: 116.0 115.0 118.0 114.0 113.0 115.0 113.0 113.0 114.0 114.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:127.00 stddev:14.66 (11.5%) stddev-sans-first:13.65 02:55:00 INFO - PROCESS | 1668 | Values: 142.0 109.0 109.0 143.0 111.0 108.0 132.0 109.0 122.0 135.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:0.94 (0.5%) stddev-sans-first:0.93 02:55:00 INFO - PROCESS | 1668 | Values: 182.0 184.0 183.0 183.0 183.0 183.0 184.0 184.0 181.0 183.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:67.60 Median:61.00 stddev:13.87 (22.7%) stddev-sans-first:11.84 02:55:00 INFO - PROCESS | 1668 | Values: 91.0 59.0 60.0 89.0 60.0 62.0 58.0 58.0 82.0 57.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:79.50 stddev:20.07 (25.2%) stddev-sans-first:21.09 02:55:00 INFO - PROCESS | 1668 | Values: 92.0 97.0 129.0 69.0 67.0 69.0 93.0 68.0 68.0 90.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.90 (2.1%) stddev-sans-first:1.94 02:55:00 INFO - PROCESS | 1668 | Values: 89.0 86.0 90.0 87.0 88.0 85.0 90.0 87.0 89.0 85.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:109.90 Median:96.00 stddev:22.87 (23.8%) stddev-sans-first:23.70 02:55:00 INFO - PROCESS | 1668 | Values: 96.0 113.0 161.0 97.0 96.0 96.0 96.0 97.0 106.0 141.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.00 stddev:1.72 (2.0%) stddev-sans-first:1.81 02:55:00 INFO - PROCESS | 1668 | Values: 85.0 85.0 85.0 84.0 85.0 86.0 84.0 86.0 85.0 90.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.95 (3.4%) stddev-sans-first:2.05 02:55:00 INFO - PROCESS | 1668 | Values: 57.0 54.0 55.0 53.0 55.0 58.0 59.0 58.0 57.0 57.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:3.78 (5.2%) stddev-sans-first:3.66 02:55:00 INFO - PROCESS | 1668 | Values: 67.0 73.0 80.0 73.0 74.0 69.0 69.0 69.0 69.0 71.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:82.00 stddev:6.80 (8.3%) stddev-sans-first:7.10 02:55:00 INFO - PROCESS | 1668 | Values: 82.0 82.0 82.0 86.0 82.0 81.0 85.0 90.0 103.0 81.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:142.00 stddev:11.48 (8.1%) stddev-sans-first:12.18 02:55:00 INFO - PROCESS | 1668 | Values: 142.0 146.0 149.0 133.0 136.0 140.0 142.0 141.0 168.0 124.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.00 stddev:2.46 (1.5%) stddev-sans-first:2.54 02:55:00 INFO - PROCESS | 1668 | Values: 162.0 161.0 164.0 164.0 160.0 165.0 164.0 169.0 163.0 164.0 02:55:00 INFO - PROCESS | 1668 | 02:55:00 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:67.00 stddev:3.66 (5.5%) stddev-sans-first:3.84 02:55:00 INFO - PROCESS | 1668 | Values: 67.0 67.0 66.0 67.0 67.0 69.0 66.0 66.0 73.0 77.0 02:55:00 INFO - PROCESS | 1668 | -------- Summary: end -------- 02:55:00 INFO - PROCESS | 1668 | 02:55:01 INFO - TEST-INFO | 1668: exit 0 02:55:01 INFO - TEST-OK | kraken | took 59239ms 02:55:01 INFO - SUITE-END | took 1177s 02:55:01 INFO - Completed test suite (00:19:37) 02:55:01 INFO - javascript benchmark 02:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2862.899798507052, 3316.369889720954, 3349.9665003349974, 3360.8487618057184, 3396.269801992571, 5754.050581654027, 5791.71041447928, 5796.768129274829, 5797.072468405056, 5814.854628634281, 5737.684427356494, 5821.155932389801, 5827.184194212814, 5829.679367634779, 5839.5620328475425, 5233.58131349493, 5255.684658920458, 5259.7107159106135, 5298.682079075248, 5314.256004159421, 5223.843284701465, 5230.7123108229225, 5365.463453654643, 5369.704666243355, 5373.24774531564, 5286.920696189561, 5324.733763311839, 5325.520703136717, 5329.0, 5342.492463215988, 5310.495502927216, 5317.175837745156, 5336.759845806948, 5348.625596208228, 5359.598030147755, 5205.76263977569, 5268.736563171826, 5289.735513224324, 5294.549963253128, 5306.787728490855, 5891.116332550152, 5898.203742494751, 5903.439173278532, 5904.911426328608, 5910.290765108214, 6216.191895053614, 6234.87530249397, 6237.968810155966, 6253.499720022387, 6255.749770009194, 6249.937500624981, 6271.122042913996, 6280.654563998978, 6296.87406251877, 6306.747730090791, 5872.17789509469, 5879.206307148523, 5901.3508514063415, 5909.438603332676, 5978.701064946736, 6179.536534759911, 6238.344973777779, 6243.8126856194385, 6266.060090986389, 6274.1843560336865, 6186.721597528122, 6199.0, 6202.131701561785, 6231.22109736283, 6300.464460520815, 6327.58870673414, 6342.936570634234, 6347.0, 6350.968245158837, 6356.523260755462, 6118.649636126507, 6185.443310102022, 6233.158523599347, 6262.12330273762, 6324.367563243639, 6315.778947736807, 6337.207849018872, 6354.491640668735, 6362.141110950055, 6365.745370185234, 5008.073506401254, 5011.57401620859, 5017.247412888096, 5018.573421259234, 5024.045431368028, 4419.756913369732, 4448.421705178306, 4460.241758900995, 4466.553344665573, 4497.415336006298, 5880.794172203952, 5946.8810623787285, 5974.522038236931, 5990.73041713124, 6004.309504407049, 6256.937430625636, 6265.561410701207, 6284.340144284875, 6305.4009869062365, 6307.022411526221, 5704.030314846486, 5740.598158128891, 5958.821235362946, 5977.880442391215, 6013.909791353133, 4717.410323709536, 5432.511074003359, 5444.265024221759, 5497.5601951843755, 5531.3915469298345, 6361.236651601837, 6365.713542890674, 6386.0, 6389.233292004989, 6392.680365981682, 6249.687515624109, 6288.339724328879, 6289.182406287154, 6293.150424692608, 6310.968445157745, 6231.906521402092, 6277.2153480814895, 6282.371762823681, 6336.7465301389275, 6372.6495042773095, 6242.094896239929, 6293.150424692791, 6298.527610429144, 6300.936990630035, 6324.17785687876, 6137.754489820536, 6313.55805093639, 6316.715747791269, 6317.6209427434505, 6332.113504109337, 6034.547408944259, 6083.6349819011, 6112.381899552462, 6141.385861414002, 6158.7228574715145, 6216.347283535345, 6217.067439883873, 6221.2845522765465, 6225.62646241227, 6228.968855155696, 6051.213342265477, 6069.089636554552, 6071.878562428815, 6076.1493390924425, 6086.087086936995, 6094.146819445193, 6112.266528016667, 6121.54443000217, 6164.137020817179, 6212.596181248205, 5996.430339117776, 6070.817875463743, 6077.453029227391, 6101.328853825987, 6131.785387511416], "value": 5778.228655740126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.801855202263, 522.4409881426873, 529.9788008479662, 543.7661805423667, 549.1625271461024, 31985.840070799673, 41193.0, 42037.94905127373, 42293.78853105738, 44696.776516117374, 43629.78185109078, 43798.562014379844, 43872.0, 43946.34080488787, 44157.77921110398, 9274.072592740706, 9300.441973481613, 9779.706608801729, 9985.20118390527, 9995.350302230368, 8905.866412003825, 9122.543872806365, 12181.51273949041, 12382.31897245651, 12415.751684966295, 12344.197627154252, 12424.93787531061, 12442.564510242144, 12468.0, 12487.937560312232, 8918.955405222998, 12212.755744885097, 12286.262824230575, 12302.630921072292, 12303.815442768366, 8790.296776257885, 11904.702382440422, 12251.0, 12251.877481225163, 12516.936060434873, 33258.83370583132, 41224.587754122374, 41236.79381603103, 41297.58702412998, 41367.965800854916, 3243.2702641905385, 3313.486409606515, 3327.0, 3617.9095522611883, 3970.602939706035, 30457.0, 30902.22744431385, 31177.532337014964, 32055.19862003445, 33038.83480582606, 3208.374366998436, 3250.5449237106823, 3256.902292931216, 3262.2333751568362, 3262.559554460165, 450099.0, 451539.0, 453712.0, 455520.0, 456094.0, 34064.48903266453, 63187.36812631815, 63315.683421582595, 63369.683151583944, 63372.0, 34976.65023349785, 36207.094822629646, 36281.91154265376, 36355.45466818, 36401.27197456036, 15035.699286014218, 15477.22613869302, 15655.68688626244, 15669.843301567067, 15685.0, 11789.233699809656, 12028.27830330183, 13000.414981325863, 13121.606351809462, 13129.01532385075, 7427.740029099064, 7707.537547747153, 7908.485948413335, 7917.841643167105, 7940.801479963047, 3217.420864244412, 3217.790843595159, 3228.273638431381, 3230.2085988932863, 3259.4947783093658, 932.8973812880578, 936.0686117313181, 943.7687766497252, 975.6780262513496, 1020.637673625867, 30092.398152036836, 30851.8457407716, 31041.689583104333, 31054.844725776227, 31809.0, 1012.8581998520214, 1044.4203467075845, 1052.894710528941, 1054.7890421915647, 1129.5538262386476, 15421.460248891235, 15806.92096539533, 15866.04803711781, 15978.402159784162, 16245.59386015359, 204105.0, 204773.0, 204804.0, 205044.0, 205359.0, 60226.0, 60522.0, 60930.69534652298, 61037.69481152566, 61171.41214408937, 1224.5101959216206, 1244.8506179258547, 1245.0226572140825, 1370.9794353084712, 1376.181172202538, 27523.0, 32009.0, 32605.85879494206, 32908.0, 33153.50269746004, 57312.713436432554, 58130.709346453, 58138.0, 58244.835103298545, 58354.4164558349, 631624.0, 639028.0, 639406.0, 639957.0, 640117.0, 27114.0, 27506.862465687544, 27596.0, 27645.58531621987, 36606.63393366032, 39989.0, 41783.791081045616, 48713.75643121762, 48956.0, 50624.98750024905, 39661.46169825775, 40289.395659065725, 40534.797326013184, 41971.16057678768, 42246.78876605597, 40370.0, 40568.98577535585, 41100.588994109676, 41504.79247603743, 41788.582114179684, 32648.673513264563, 38331.23337533289, 38630.22739545249, 39000.414993774546, 39352.803235983636, 28357.858210708815, 35133.648663513035, 35587.64412355947, 36237.63762362448, 36377.636223637426, 26330.60504092402, 26369.0, 26460.206193814218, 26829.865850670623, 26951.730482695708], "value": 18834.681853252037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.8788642145617, 354.8527361145125, 378.8238469111864, 386.3837179698382, 408.6751032928821, 14504.274786260685, 15164.090154590718, 20191.09140088696, 20607.1757129715, 21934.670979935312, 20451.0, 20459.693104603444, 20914.89542552289, 21130.89434552825, 21378.786212137875, 5813.186153938452, 6152.261728592575, 6154.107654390111, 6156.107364432155, 6158.938410615904, 4155.854545090922, 4166.458360413142, 4225.323948168294, 6021.0, 6837.042814006043, 6843.589384636913, 6850.623215723133, 6857.07429497019, 6864.931350686479, 6875.381215690587, 6590.242122155942, 6683.42688065096, 6778.728850845961, 6804.387605115514, 6818.4886133539685, 5240.816571419982, 5650.124230744241, 5900.409959004108, 5903.203067585864, 5912.231409916726, 26321.73678263212, 26322.6051609226, 26427.867860660765, 26606.6009009865, 26695.866520667467, 2065.1120018392085, 2134.231676596424, 2155.3964889830872, 2176.7279090113734, 2340.742518322983, 10207.693769186937, 10244.53899574521, 10506.684799456028, 10517.1060459861, 11171.329720216812, 1850.6206227723285, 1863.1988245054622, 1887.2639670528367, 1911.5603411215498, 1968.7342208801772, 113099.86900130975, 115148.0, 124097.0, 129156.0, 133417.99999999904, 11496.0, 11592.43502127202, 11723.179377443668, 11759.764804703858, 11873.525058997717, 12845.229286242855, 13343.532976345781, 13357.065005449525, 13441.39513721885, 14146.080504767364, 8467.915320846836, 8502.574871256536, 8610.569471526398, 8756.299496040301, 8791.51646659427, 8597.054324024351, 8627.827443451095, 8694.17405346491, 8797.252233560219, 8817.0, 4476.2837945928495, 4542.432195975503, 4569.680122391467, 4582.518835522289, 4666.65000124992, 1651.7274649682668, 1853.1604247738214, 1919.2610844824842, 1920.875143115693, 1954.2933037742828, 843.8818565400849, 896.9551522423983, 900.5632268349846, 932.5383934952107, 949.4588084791741, 20884.0, 21836.45408864791, 21843.344699659036, 21892.9053547322, 21895.0, 924.568385147059, 927.9814403711888, 931.5481991234382, 932.5616960028775, 974.605284859633, 10708.892911070945, 11366.715832104264, 11399.316041037398, 11421.0, 11462.312261264351, 526804.0, 602748.0, 613443.0, 613452.0, 625095.0, 72551.2744872555, 77170.0, 78464.0, 118996.0, 142224.288878557, 949.4303417949313, 981.1464026297167, 985.7486340983147, 1000.9049140331657, 1002.9097381235578, 19189.80810191936, 19359.51601209981, 20030.198792048737, 20056.398308050782, 20120.89939550293, 57675.42324576701, 58279.70860145842, 58729.0, 59275.0, 59293.0, 87046.56476717576, 89576.552117239, 89845.55077224573, 89883.0, 91999.54000230224, 7728.149903510722, 8018.959905200437, 8090.0, 8175.427720059539, 8394.790130246549, 11939.104567157325, 13065.804012939623, 13194.0, 13228.801567976681, 13461.326933653083, 11185.150165468098, 11682.415879205835, 11704.414779260833, 11726.41367931617, 11781.941090294493, 10987.956144166292, 11269.211155219056, 11382.032527235278, 11459.942700286778, 11733.237339572901, 11483.540658373571, 11511.19421640477, 11560.30638161713, 11685.76628467409, 11952.983996360406, 8090.959545202471, 8199.426040177368, 8229.753107406787, 8370.455920365157, 8444.619992100248, 10372.792544148924, 11129.554817807197, 11168.832467512831, 11306.208565400342, 11537.423128843357], "value": 9676.163783379507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.5694177863088, 1524.420720126352, 1535.593067837023, 1727.127800460768, 1906.132709617125, 7844.1763614820475, 8374.120717324677, 8714.259287960514, 8890.155435233659, 8939.463632182074, 7822.726204582841, 8722.778810966454, 8804.0, 8878.866816997734, 8883.333749968762, 2339.7660233976635, 2376.310869847742, 2378.2389635316704, 2378.702662167229, 2381.559411508868, 2326.406766274606, 2363.243761996162, 2371.1463873005705, 2374.7387787343378, 2377.132346693453, 2037.8981050947468, 2310.1798861404213, 2327.394877331889, 2358.575456417844, 2368.7275963264187, 2296.024189719379, 2331.207389487574, 2333.9183128590503, 2340.6137987232087, 2344.39045848079, 2322.6516022596575, 2328.0571368595747, 2334.6264597664294, 2335.1243283768586, 2340.73081595617, 8763.605637746317, 8843.425177363515, 8886.155815197546, 8893.199612034883, 8895.688650897187, 5269.552088072518, 5414.620976531644, 5432.185172224198, 5437.782488700447, 5448.945510544883, 3566.8038257895805, 3571.8035508047046, 3606.278744251134, 3663.102539877747, 3686.1153323202507, 1079.3685693869018, 1080.9135269178446, 1085.7557049663842, 1095.1348434736549, 1104.0174244922025, 9959.850602240973, 11721.062315014779, 11849.0, 11853.525858965631, 11880.108991825648, 4744.018014005408, 4786.114568804782, 4800.207965685623, 4903.509649035068, 4922.8769280768265, 8793.604287807064, 10240.897591024144, 10242.487875606339, 10262.281640285108, 10274.0, 5502.889942201214, 5506.146547285177, 5508.669479831223, 5515.7242137892945, 5518.668879867221, 4016.4176194451643, 4496.258117410656, 4648.325992731103, 4905.0, 5049.091163590516, 4004.6395824375945, 4089.672826173899, 4098.836046558164, 4148.522919864255, 4155.314373128461, 1043.0664555223034, 1178.4461303187488, 1192.9582464613698, 1227.3924407418385, 1269.968250793719, 826.5082276045744, 887.9955600222087, 900.8513595256709, 919.9034101419388, 920.5673333533229, 5436.0, 5816.563757718188, 5859.648421094748, 5926.970365148233, 6020.187274717945, 933.6685476655825, 946.7822400847843, 956.5073986896754, 959.5490119643756, 1019.6278358399279, 3813.828377723009, 3915.47141135943, 3977.602239776057, 4026.295398305285, 4026.5369482509886, 10173.54219060144, 10637.680869573926, 10797.406142662072, 10804.13566914645, 10804.837927431096, 10209.438480883475, 10601.310914790514, 10635.734106647242, 10770.299930504649, 10791.56833726642, 8020.438569300093, 8338.24955753985, 8350.624221909908, 8357.791055223668, 8373.832523349622, 5788.768449262151, 5844.12338149281, 5911.467967882912, 6075.817725468243, 6090.3605121461605, 9679.66121185755, 10160.33957792741, 10283.125934295369, 10303.896961030294, 10336.844947325646, 7934.642941067781, 9417.811643766949, 10482.423466709099, 10497.42264175447, 10497.842532361869, 6974.37230649244, 7384.076990376203, 7533.623318834146, 7629.847403052019, 7729.0, 8300.916990830014, 8313.6674533018, 8318.168183181633, 8412.789680258042, 8430.494170349799, 7519.548827070394, 7539.095308563007, 7545.132309784225, 7587.848243034998, 7623.9618801905635, 7391.704331826882, 7408.333250007309, 7458.216887226763, 7509.1739908608915, 7563.924360756542, 6822.965885170543, 6905.930940690529, 6931.480138989495, 6964.199117101395, 6974.476914231352, 4814.229723244264, 4833.3958255218095, 4859.829905953275, 4974.7512624369365, 5128.8461346159675, 4918.081531919989, 4946.233333833262, 4974.676646017997, 5058.519440653132, 5093.643444958965], "value": 4593.661485658715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.64043148222123, 302.3514561266084, 310.16565438969167, 314.2066282636342, 317.0678206074142, 5425.891482170359, 5438.8912221755545, 5482.396936337, 5490.725463726808, 5538.6122971391915, 5092.79628814847, 5212.635115541913, 5218.39988401334, 5257.737113144337, 5442.9727851360785, 3449.6722811332884, 4017.372963949605, 4145.398917157003, 4150.6172469437315, 4155.293600087993, 3438.0403170192876, 4106.589341065885, 4147.315692910666, 4190.203861266365, 4218.4516012918275, 3840.3087444260022, 4078.959865234361, 4150.958490415087, 4158.313878210091, 4195.559466256045, 3258.902232933016, 3453.2920751246183, 3925.7612469712603, 4136.172765446892, 4153.231652144363, 3560.394732895414, 3570.214552798406, 3575.7496975211748, 3577.463380492921, 3585.31878943, 4725.589949125936, 5285.7357132143625, 5338.679679219259, 5380.24676545284, 5390.110631745757, 4004.2992476316817, 4316.309390497506, 4474.977625111854, 4702.506236845151, 4716.38686970695, 5272.472752724735, 5463.262459567987, 5658.8019419320535, 5720.914186287209, 5760.8271751847515, 3372.4266874631126, 3845.6923446124524, 3866.420036994445, 3885.436611691317, 3893.53277606689, 4848.854534363974, 5035.0, 6072.7570897164505, 6075.362086980847, 6114.480269177126, 3368.882089126869, 3912.8239229234755, 3947.6972599042247, 3961.7821019844187, 3974.5627980922077, 3549.8225088745976, 3970.68234541236, 3988.1624858779983, 4020.6783457323927, 4023.879283621496, 3936.645701886844, 4507.706999045052, 4596.264597664424, 4640.883977900579, 4683.601893838993, 5745.942540574624, 5754.9424505754405, 5764.682942438206, 5784.863822367028, 5792.681402522901, 1126.5043380912373, 1281.2248589603341, 1345.4080204709896, 1351.3108314759543, 1361.3873756809476, 859.7377799771004, 875.8919966242709, 879.147227189625, 908.977275568116, 911.0707078779608, 5286.312779338661, 5307.28351672527, 5329.0, 5329.973350133225, 5338.572914166857, 5509.669419834822, 5700.344460387026, 5826.126081087786, 5833.620814647034, 5841.795537156179, 4143.875683729493, 4639.373684552542, 5289.312389389432, 5291.7354132294, 5292.92060619091, 2870.3254735137225, 3014.5930299409297, 3032.818030918152, 3032.999110293598, 3054.037978036911, 5727.885442291131, 5956.195913551615, 5970.910436343458, 5992.202339298193, 6121.541773428986, 5246.921296180561, 5989.9101513477335, 6085.908711369333, 6127.0, 6155.199824022849, 4985.077760614226, 5304.628675992721, 6199.969000154971, 6216.44052035319, 6252.187215661935, 4856.635752318661, 5564.4991950724625, 5896.705164741831, 5902.911456328073, 5910.704464776658, 4816.686915350491, 5584.910942366362, 5789.884202315846, 5806.2451881255165, 5829.6793676346515, 5248.0, 5634.943650563606, 5734.967705812994, 5784.913226301524, 5921.0, 3957.2085582882964, 3962.980185099171, 3995.5604883462215, 3996.540397854284, 4031.496062992126, 6008.609440386361, 6013.729382177725, 6067.817965460867, 6072.908906366496, 6077.939220607737, 5106.821261255986, 5185.585153187661, 5540.418256083214, 5680.103147394776, 5917.408259174221, 4827.138289368561, 5772.787714579985, 5806.390329015392, 5807.883842323215, 5808.5062769665055, 4444.955550444454, 4834.817882531655, 5297.337832770903, 5659.660420374791, 5720.17057526648, 5095.87260318495, 5581.358143813513, 5682.334893993434, 5748.568857335633, 5759.568032397503, 4955.975220123876, 5072.51811077947, 5362.436944120967, 5597.921143371048, 5670.0], "value": 4151.315579379031, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6249025526216, 708.4084789201017, 712.7505373119405, 733.7945375294919, 781.2304879693501, 14762.926185369084, 16008.199590020511, 16011.839881601181, 16033.038017718945, 16111.274992625331, 14040.227787471686, 14139.787903181461, 14183.361748721307, 14201.14793112414, 14219.786703199461, 662.9602223866559, 678.9219239787413, 685.0785693242581, 819.512390127873, 828.9544075075884, 845.5011543189516, 845.7547311279721, 860.2386887604453, 861.2937391339104, 861.8577934640776, 880.9559522023906, 881.8280435315116, 918.7197904639082, 920.7928216151379, 925.2459245714721, 702.7294491620712, 723.5043994863536, 914.8810654614924, 915.5971372596036, 916.3493919317259, 639.4660458517144, 655.7213184396612, 659.8581305019444, 660.0824853453703, 660.5904339309611, 15127.924360378238, 15201.543953681406, 15215.467458638894, 15235.238238088052, 15255.313510891925, 13308.735670111324, 13825.377857996315, 14034.578962631138, 14047.578572642837, 14142.717145657132, 11669.883301166965, 12153.93923030388, 12616.369181540886, 12662.0, 12963.935180324132, 4533.886652833706, 4554.203014472454, 4600.102979918917, 4734.100520901018, 4755.38180036593, 122939.38530307381, 125021.37489312496, 125222.0, 127131.09303360457, 127829.0, 10119.24105692076, 10289.845652315222, 10671.35971841692, 10758.838617420744, 11207.60773372928, 21085.156593736385, 21151.0, 21307.68038479424, 21474.355769326947, 21549.922503874743, 7205.92794072063, 7608.581528015901, 7620.3522700571075, 7737.767866964, 7835.804104897309, 4229.936550951738, 4274.529801721808, 4356.520782713899, 4389.209942210433, 4464.2633965396, 3509.982450087733, 3623.3840247158046, 3630.0743310455664, 3637.7089832813313, 3656.2504686539196, 682.7815099168218, 697.9461013868993, 723.9529430586995, 731.2833423245249, 733.9633018349061, 589.3134498309507, 598.9131575921467, 668.9632070236087, 669.0, 672.6972862212024, 8564.828703425897, 9096.90903090974, 9258.444493330422, 9543.665971690958, 9647.517624118906, 642.2100815996257, 665.6779051483421, 674.6222115615271, 678.633537889544, 688.0436193690774, 4008.358662614026, 4504.369388285642, 4697.4832768395445, 4701.27130294798, 4741.976290118596, 78561.60719196367, 131330.03004954933, 162491.0, 163602.0, 177955.11022444806, 115768.8423115758, 116034.8396516041, 117431.8256817438, 147445.0, 148300.0, 79719.80420293585, 86658.56670716606, 93227.0, 103752.44371334436, 111750.44124779486, 8534.231919127309, 9519.810023747032, 9524.0, 9916.504174791376, 10023.799524009624, 54056.0, 56342.718286409945, 58695.30437564899, 58920.41079589149, 59200.519986998945, 89711.0, 90013.0, 92381.53809230911, 93310.0, 95714.52142739242, 12740.108192426442, 12853.93573032129, 13002.934985325013, 13127.671808204872, 13228.206307621573, 12040.0, 13586.93206533961, 13776.380062896993, 14382.0, 14960.251987400805, 13942.58172254834, 14193.432262709375, 14416.279186040865, 14475.710485790436, 14546.563603091925, 13097.934510327388, 13236.272005039815, 13549.661258468223, 14632.561023169323, 14652.26738663084, 12772.169808962388, 13333.266670333225, 13563.118397304144, 13720.794188087386, 13796.931015344859, 9800.41197528122, 10392.58429662805, 10653.89346106529, 11120.555177792798, 11528.538858445569, 11046.613368532062, 11086.445677716243, 11114.777704446027, 11254.381009044253, 11359.943200283946], "value": 7806.158109228817, "unit": "score"}], "name": "dromaeo_css", "value": 7343.113169029063, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 118.0, 114.0, 113.0, 115.0, 113.0, 113.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 109.0, 143.0, 111.0, 108.0, 132.0, 109.0, 122.0, 135.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 183.0, 183.0, 183.0, 184.0, 184.0, 181.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 59.0, 60.0, 89.0, 60.0, 62.0, 58.0, 58.0, 82.0, 57.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 97.0, 129.0, 69.0, 67.0, 69.0, 93.0, 68.0, 68.0, 90.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 88.0, 85.0, 90.0, 87.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 113.0, 161.0, 97.0, 96.0, 96.0, 96.0, 97.0, 106.0, 141.0], "value": 109.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 86.0, 84.0, 86.0, 85.0, 90.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 53.0, 55.0, 58.0, 59.0, 58.0, 57.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 80.0, 73.0, 74.0, 69.0, 69.0, 69.0, 69.0, 71.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 86.0, 82.0, 81.0, 85.0, 90.0, 103.0, 81.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 146.0, 149.0, 133.0, 136.0, 140.0, 142.0, 141.0, 168.0, 124.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 164.0, 160.0, 165.0, 164.0, 169.0, 163.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 69.0, 66.0, 66.0, 73.0, 77.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1441.6, "alertThreshold": 2.0}]} 02:55:01 INFO - Return code: 0 02:55:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:55:02 INFO - # TBPL SUCCESS # 02:55:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:55:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:55:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:55:02 INFO - 2016-10-13 02:55:02.075 screenresolution[1672:10256] starting screenresolution argv=screenresolution get 02:55:02 INFO - 2016-10-13 02:55:02.078 screenresolution[1672:10256] Display 0: 1600x1200x32@60 02:55:02 INFO - 2016-10-13 02:55:02.084 screenresolution[1673:10259] starting screenresolution argv=screenresolution list 02:55:02 INFO - Available Modes on Display 0 02:55:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:55:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:55:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:55:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:55:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:55:02 INFO - Intel Iris: 02:55:02 INFO - Chipset Model: Intel Iris 02:55:02 INFO - Type: GPU 02:55:02 INFO - Bus: Built-In 02:55:02 INFO - VRAM (Dynamic, Max): 1536 MB 02:55:02 INFO - Vendor: Intel (0x8086) 02:55:02 INFO - Device ID: 0x0a2e 02:55:02 INFO - Revision ID: 0x0009 02:55:02 INFO - Displays: 02:55:02 INFO - Display: 02:55:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:55:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:55:02 INFO - Display Serial Number: 1600x1200 60 02:55:02 INFO - Main Display: Yes 02:55:02 INFO - Mirror: Off 02:55:02 INFO - Online: Yes 02:55:02 INFO - Rotation: Supported 02:55:02 INFO - Return code: 0 02:55:02 INFO - Running post-action listener: _resource_record_post_action 02:55:02 INFO - [mozharness: 2016-10-13 09:55:02.324966Z] Finished run-tests step (success) 02:55:02 INFO - Running post-run listener: _resource_record_post_run 02:55:02 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 31964160; Write bytes: 663728128; Read time: 193; Write time: 1897 02:55:02 INFO - TinderboxPrint: CPU usage
53.3% 02:55:02 INFO - TinderboxPrint: I/O read bytes / time
31,964,160 / 193 02:55:02 INFO - TinderboxPrint: I/O write bytes / time
663,728,128 / 1,897 02:55:02 INFO - TinderboxPrint: CPU idle
2,258.8 (46.7%) 02:55:02 INFO - TinderboxPrint: CPU system
967.2 (20.0%) 02:55:02 INFO - TinderboxPrint: CPU user
1,615.7 (33.4%) 02:55:02 INFO - TinderboxPrint: Swap in / out
390,983,680 / 0 02:55:02 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356182528; Write bytes: 356234752; Read time: 27582; Write time: 751 02:55:02 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30202880; Write bytes: 296471040; Read time: 179; Write time: 1115 02:55:02 INFO - Running post-run listener: _upload_blobber_files 02:55:02 INFO - Blob upload gear active. 02:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:55:02 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 02:55:02 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'] 02:55:02 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 02:55:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:04 INFO - (blobuploader) - INFO - Done attempting. 02:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:05 INFO - (blobuploader) - INFO - Done attempting. 02:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:07 INFO - (blobuploader) - INFO - Done attempting. 02:55:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:55:07 INFO - Return code: 0 02:55:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:55:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:55:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fcdea1018345aef9dd4ea4baafcda3708229e3a9d84ee2722e8f8ed5acaef1c4618fa0bc32b5dea2d54c3d65765e47c1c49f1966c1707e8b2eaef76c5d8f6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebd6efa2937fadd012833d41fa3a8da755499d1c0368ee10cf42c1d2f7d06f80c597dbae485d2d7877b9c29077b7f113bfb44169e070447ad4b22ecc05c8e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efd8875b00c6666bdae2ca3e6cbaf3b3f9a176b89dc1e50a68fe227ddde1e2b73fbccecc4acd18573ab30816e9810444f638642b52ae02822ee3f4cd7fe858af"} 02:55:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:55:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:55:07 INFO - Contents: 02:55:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fcdea1018345aef9dd4ea4baafcda3708229e3a9d84ee2722e8f8ed5acaef1c4618fa0bc32b5dea2d54c3d65765e47c1c49f1966c1707e8b2eaef76c5d8f6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebd6efa2937fadd012833d41fa3a8da755499d1c0368ee10cf42c1d2f7d06f80c597dbae485d2d7877b9c29077b7f113bfb44169e070447ad4b22ecc05c8e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efd8875b00c6666bdae2ca3e6cbaf3b3f9a176b89dc1e50a68fe227ddde1e2b73fbccecc4acd18573ab30816e9810444f638642b52ae02822ee3f4cd7fe858af"} 02:55:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:55:07 INFO - Copying logs to upload dir... 02:55:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:55:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.420813 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-13 02:55:07.994881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 02:55:07.998231) ========= 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.b54E7wp6Co/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.KJLRjvUmOl/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fcdea1018345aef9dd4ea4baafcda3708229e3a9d84ee2722e8f8ed5acaef1c4618fa0bc32b5dea2d54c3d65765e47c1c49f1966c1707e8b2eaef76c5d8f6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebd6efa2937fadd012833d41fa3a8da755499d1c0368ee10cf42c1d2f7d06f80c597dbae485d2d7877b9c29077b7f113bfb44169e070447ad4b22ecc05c8e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efd8875b00c6666bdae2ca3e6cbaf3b3f9a176b89dc1e50a68fe227ddde1e2b73fbccecc4acd18573ab30816e9810444f638642b52ae02822ee3f4cd7fe858af"} build_url:https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/eRPbcZg9QD6mETNMtdAn6Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fcdea1018345aef9dd4ea4baafcda3708229e3a9d84ee2722e8f8ed5acaef1c4618fa0bc32b5dea2d54c3d65765e47c1c49f1966c1707e8b2eaef76c5d8f6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebd6efa2937fadd012833d41fa3a8da755499d1c0368ee10cf42c1d2f7d06f80c597dbae485d2d7877b9c29077b7f113bfb44169e070447ad4b22ecc05c8e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efd8875b00c6666bdae2ca3e6cbaf3b3f9a176b89dc1e50a68fe227ddde1e2b73fbccecc4acd18573ab30816e9810444f638642b52ae02822ee3f4cd7fe858af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 02:55:08.030750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:55:08.031117) ========= 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.b54E7wp6Co/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.KJLRjvUmOl/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.004972 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:55:08.080761) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 02:55:08.081144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 02:55:08.081496) ========= ========= Total master_lag: 0.19 =========