builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0035 starttime: 1475843812.37 results: success (0) buildid: 20161007033200 builduid: 45f4789a976f4f7fa37e2db98682c814 revision: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.369600) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.370056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.370354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.395132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.395544) ========= 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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-07 05:36:52-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-10-07 05:36:52 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.505126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.505465) ========= 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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.028903 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:52.554903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 05:36:52.555263) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 --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 f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yHeyLDgSDd/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.Buf8gQV4yN/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-07 05:36:52,622 truncating revision to first 12 chars 2016-10-07 05:36:52,622 Setting DEBUG logging. 2016-10-07 05:36:52,622 attempt 1/10 2016-10-07 05:36:52,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f161a85e85e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 05:36:53,673 unpacking tar archive at: mozilla-aurora-f161a85e85e4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 05:36:53.907795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:53.908130) ========= script_repo_revision: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:53.908530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:53.908797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:53.928889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-07 05:36:53.929528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yHeyLDgSDd/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.Buf8gQV4yN/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:36:54 INFO - MultiFileLogger online at 20161007 05:36:54 in /builds/slave/test 05:36:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:36:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:54 INFO - {'append_to_log': False, 05:36:54 INFO - 'base_work_dir': '/builds/slave/test', 05:36:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:36:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:54 INFO - 'branch': 'Mozilla-Aurora', 05:36:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:54 INFO - 'config_files': ('talos/mac_config.py',), 05:36:54 INFO - 'default_actions': ('clobber', 05:36:54 INFO - 'read-buildbot-config', 05:36:54 INFO - 'download-and-extract', 05:36:54 INFO - 'populate-webroot', 05:36:54 INFO - 'create-virtualenv', 05:36:54 INFO - 'install', 05:36:54 INFO - 'run-tests'), 05:36:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:54 INFO - 'download_minidump_stackwalk': True, 05:36:54 INFO - 'download_symbols': 'ondemand', 05:36:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:54 INFO - 'installer_path': 'installer.exe', 05:36:54 INFO - 'log_level': 'info', 05:36:54 INFO - 'log_name': 'talos', 05:36:54 INFO - 'log_to_console': True, 05:36:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:36:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:36:54 INFO - 'opt_config_files': (), 05:36:54 INFO - 'pip_index': False, 05:36:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:54 INFO - 'cmd': ('bash', 05:36:54 INFO - '-c', 05:36:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:54 INFO - 'enabled': True, 05:36:54 INFO - 'halt_on_failure': False, 05:36:54 INFO - 'name': 'check_screen_resolution'},), 05:36:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:54 INFO - 'cmd': ('bash', 05:36:54 INFO - '-c', 05:36:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:54 INFO - 'enabled': True, 05:36:54 INFO - 'halt_on_failure': False, 05:36:54 INFO - 'name': 'check_screen_resolution'},), 05:36:54 INFO - 'run_cmd_checks_enabled': True, 05:36:54 INFO - 'sps_profile': False, 05:36:54 INFO - 'sps_profile_interval': 0, 05:36:54 INFO - 'suite': 'dromaeojs-e10s', 05:36:54 INFO - 'system_bits': '32', 05:36:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:54 INFO - 'title': 't-yosemite-r7-0035', 05:36:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:54 INFO - 'use_talos_json': True, 05:36:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:54 INFO - 'work_dir': 'build'} 05:36:54 INFO - [mozharness: 2016-10-07 12:36:54.118593Z] Running clobber step. 05:36:54 INFO - Running pre-action listener: _resource_record_pre_action 05:36:54 INFO - Running main action method: clobber 05:36:54 INFO - rmtree: /builds/slave/test/build 05:36:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:56 INFO - Running post-action listener: _resource_record_post_action 05:36:56 INFO - [mozharness: 2016-10-07 12:36:56.735861Z] Finished clobber step (success) 05:36:56 INFO - [mozharness: 2016-10-07 12:36:56.736024Z] Running read-buildbot-config step. 05:36:56 INFO - Running pre-action listener: _resource_record_pre_action 05:36:56 INFO - Running main action method: read_buildbot_config 05:36:56 INFO - Using buildbot properties: 05:36:56 INFO - { 05:36:56 INFO - "project": "", 05:36:56 INFO - "product": "firefox", 05:36:56 INFO - "script_repo_revision": "production", 05:36:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 05:36:56 INFO - "repository": "", 05:36:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 05:36:56 INFO - "buildid": "20161007033200", 05:36:56 INFO - "pgo_build": "False", 05:36:56 INFO - "basedir": "/builds/slave/test", 05:36:56 INFO - "buildnumber": 420, 05:36:56 INFO - "slavename": "t-yosemite-r7-0035", 05:36:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:36:56 INFO - "platform": "yosemite_r7", 05:36:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:36:56 INFO - "branch": "mozilla-aurora", 05:36:56 INFO - "repo_path": "releases/mozilla-aurora", 05:36:56 INFO - "revision": "f161a85e85e45fd2dcc56abbcd4e43c70d177bb5", 05:36:56 INFO - "stage_platform": "macosx64", 05:36:56 INFO - "builduid": "45f4789a976f4f7fa37e2db98682c814", 05:36:56 INFO - "slavebuilddir": "test" 05:36:56 INFO - } 05:36:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:36:56 INFO - Running post-action listener: _resource_record_post_action 05:36:56 INFO - [mozharness: 2016-10-07 12:36:56.740167Z] Finished read-buildbot-config step (success) 05:36:56 INFO - [mozharness: 2016-10-07 12:36:56.740301Z] Running download-and-extract step. 05:36:56 INFO - Running pre-action listener: _resource_record_pre_action 05:36:56 INFO - Running main action method: download_and_extract 05:36:56 INFO - mkdir: /builds/slave/test/build/tests 05:36:56 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')]} 05:36:56 INFO - trying https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:36:56 INFO - Downloading https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/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 05:36:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/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 05:36:57 INFO - Downloaded 1199 bytes. 05:36:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:36:57 INFO - Using the following test package requirements: 05:36:57 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:36:57 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:36:57 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:36:57 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'jsshell-mac.zip'], 05:36:57 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:36:57 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:36:57 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:36:57 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:36:57 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:36:57 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:57 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:36:57 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:36:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:36:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:36:57 INFO - Fetch https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:36:58 INFO - Expected file size: 16434722 05:37:05 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 05:37:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:37:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:37:05 INFO - Fetch https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:37:06 INFO - Expected file size: 16434722 05:37:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:37:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:37:12 INFO - Fetch https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:37:13 INFO - Expected file size: 14414059 05:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:13 INFO - trying https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:37:13 INFO - Downloading https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/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 05:37:16 INFO - Downloaded 115310260 bytes. 05:37:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:37:16 INFO - mkdir: /builds/slave/test/properties 05:37:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:16 INFO - Contents: 05:37:16 INFO - build_url:https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:37:17 INFO - Running post-action listener: _resource_record_post_action 05:37:17 INFO - Running post-action listener: set_extra_try_arguments 05:37:17 INFO - [mozharness: 2016-10-07 12:37:17.493180Z] Finished download-and-extract step (success) 05:37:17 INFO - [mozharness: 2016-10-07 12:37:17.493306Z] Running populate-webroot step. 05:37:17 INFO - Running pre-action listener: _resource_record_pre_action 05:37:17 INFO - Running main action method: populate_webroot 05:37:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:17 INFO - '--tppagecycles', 05:37:17 INFO - '7'], 05:37:17 INFO - 'tests': ['tsvgm']}}, 05:37:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:37:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:37:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['damp', 'tps']}, 05:37:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'tests': ['damp', 'tps']}, 05:37:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['dromaeo_dom']}, 05:37:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['basic_compositor_video']}, 05:37:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:37:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['a11yr', 05:37:17 INFO - 'ts_paint', 05:37:17 INFO - 'tpaint', 05:37:17 INFO - 'sessionrestore', 05:37:17 INFO - 'sessionrestore_no_auto_restore', 05:37:17 INFO - 'tabpaint']}, 05:37:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:37:17 INFO - 'ts_paint', 05:37:17 INFO - 'tpaint', 05:37:17 INFO - 'sessionrestore', 05:37:17 INFO - 'sessionrestore_no_auto_restore', 05:37:17 INFO - 'tabpaint']}, 05:37:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:37:17 INFO - 'ts_paint', 05:37:17 INFO - 'tpaint', 05:37:17 INFO - 'sessionrestore', 05:37:17 INFO - 'sessionrestore_no_auto_restore', 05:37:17 INFO - 'tabpaint']}, 05:37:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:37:17 INFO - 'ts_paint', 05:37:17 INFO - 'tpaint', 05:37:17 INFO - 'sessionrestore', 05:37:17 INFO - 'sessionrestore_no_auto_restore', 05:37:17 INFO - 'tabpaint']}, 05:37:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['a11yr', 05:37:17 INFO - 'ts_paint', 05:37:17 INFO - 'tpaint', 05:37:17 INFO - 'sessionrestore', 05:37:17 INFO - 'sessionrestore_no_auto_restore', 05:37:17 INFO - 'tabpaint']}, 05:37:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['a11yr', 05:37:17 INFO - 'ts_paint', 05:37:17 INFO - 'tpaint', 05:37:17 INFO - 'sessionrestore', 05:37:17 INFO - 'sessionrestore_no_auto_restore', 05:37:17 INFO - 'tabpaint']}, 05:37:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['tsvgx', 05:37:17 INFO - 'tsvgr_opacity', 05:37:17 INFO - 'tart', 05:37:17 INFO - 'tscrollx', 05:37:17 INFO - 'cart']}, 05:37:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:37:17 INFO - 'tsvgr_opacity', 05:37:17 INFO - 'tart', 05:37:17 INFO - 'tscrollx', 05:37:17 INFO - 'cart']}, 05:37:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'talos_options': ['--disable-e10s'], 05:37:17 INFO - 'tests': ['tp5o']}, 05:37:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'tests': ['tp5o']}, 05:37:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'talos_options': ['--disable-e10s', 05:37:17 INFO - '--xperf_path', 05:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:17 INFO - 'tests': ['tp5n']}, 05:37:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:17 INFO - 'talos_options': ['--xperf_path', 05:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:17 INFO - 'tests': ['tp5n']}}, 05:37:17 INFO - 'talos.zip': {'path': '', 05:37:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:17 INFO - Running post-action listener: _resource_record_post_action 05:37:17 INFO - [mozharness: 2016-10-07 12:37:17.511932Z] Finished populate-webroot step (success) 05:37:17 INFO - [mozharness: 2016-10-07 12:37:17.512070Z] Running create-virtualenv step. 05:37:17 INFO - Running pre-action listener: _resource_record_pre_action 05:37:17 INFO - Running main action method: create_virtualenv 05:37:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:17 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 05:37:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:17 INFO - Using real prefix '/tools/python27' 05:37:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:21 INFO - Installing pip.................done. 05:37:21 INFO - Return code: 0 05:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:21 INFO - 'HOME': '/Users/cltbld', 05:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:21 INFO - 'LOGNAME': 'cltbld', 05:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:21 INFO - 'MOZ_NO_REMOTE': '1', 05:37:21 INFO - 'NO_EM_RESTART': '1', 05:37:21 INFO - 'PAGER': '/bin/cat', 05:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:21 INFO - 'PWD': '/builds/slave/test', 05:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:21 INFO - 'SHELL': '/bin/bash', 05:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:21 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:21 INFO - 'USER': 'cltbld', 05:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:21 INFO - 'XPC_FLAGS': '0x0', 05:37:21 INFO - 'XPC_SERVICE_NAME': '0', 05:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:21 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 05:37:21 INFO - Cleaning up... 05:37:21 INFO - Return code: 0 05:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:21 INFO - 'HOME': '/Users/cltbld', 05:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:21 INFO - 'LOGNAME': 'cltbld', 05:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:21 INFO - 'MOZ_NO_REMOTE': '1', 05:37:21 INFO - 'NO_EM_RESTART': '1', 05:37:21 INFO - 'PAGER': '/bin/cat', 05:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:21 INFO - 'PWD': '/builds/slave/test', 05:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:21 INFO - 'SHELL': '/bin/bash', 05:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:21 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:21 INFO - 'USER': 'cltbld', 05:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:21 INFO - 'XPC_FLAGS': '0x0', 05:37:21 INFO - 'XPC_SERVICE_NAME': '0', 05:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:21 INFO - Downloading/unpacking psutil>=3.1.1 05:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:25 INFO - Installing collected packages: psutil 05:37:25 INFO - Running setup.py install for psutil 05:37:25 INFO - building 'psutil._psutil_osx' extension 05:37:25 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 05:37:25 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 05:37:25 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 05:37:26 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 05:37:26 INFO - building 'psutil._psutil_posix' extension 05:37:26 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 05:37:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:37:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:37:26 INFO - ^ 05:37:26 INFO - 1 warning generated. 05:37:26 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 05:37:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:26 INFO - Successfully installed psutil 05:37:26 INFO - Cleaning up... 05:37:26 INFO - Return code: 0 05:37:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:37:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:26 INFO - 'HOME': '/Users/cltbld', 05:37:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:26 INFO - 'LOGNAME': 'cltbld', 05:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:26 INFO - 'MOZ_NO_REMOTE': '1', 05:37:26 INFO - 'NO_EM_RESTART': '1', 05:37:26 INFO - 'PAGER': '/bin/cat', 05:37:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:26 INFO - 'PWD': '/builds/slave/test', 05:37:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:26 INFO - 'SHELL': '/bin/bash', 05:37:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:26 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:26 INFO - 'USER': 'cltbld', 05:37:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:26 INFO - 'XPC_FLAGS': '0x0', 05:37:26 INFO - 'XPC_SERVICE_NAME': '0', 05:37:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:37:29 INFO - Installing collected packages: mozsystemmonitor 05:37:29 INFO - Running setup.py install for mozsystemmonitor 05:37:29 INFO - Successfully installed mozsystemmonitor 05:37:29 INFO - Cleaning up... 05:37:29 INFO - Return code: 0 05:37:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:37:29 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')]} 05:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:29 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')]} 05:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:29 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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:29 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 05:37:29 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 05:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:29 INFO - 'HOME': '/Users/cltbld', 05:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:29 INFO - 'LOGNAME': 'cltbld', 05:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:29 INFO - 'MOZ_NO_REMOTE': '1', 05:37:29 INFO - 'NO_EM_RESTART': '1', 05:37:29 INFO - 'PAGER': '/bin/cat', 05:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:29 INFO - 'PWD': '/builds/slave/test', 05:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:29 INFO - 'SHELL': '/bin/bash', 05:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:29 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:29 INFO - 'USER': 'cltbld', 05:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:29 INFO - 'XPC_FLAGS': '0x0', 05:37:29 INFO - 'XPC_SERVICE_NAME': '0', 05:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:29 INFO - Downloading/unpacking jsonschema==2.5.1 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:32 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:32 INFO - warning: no files found matching '*.txt' 05:37:32 INFO - no previously-included directories found matching 'build' 05:37:32 INFO - no previously-included directories found matching 'dist' 05:37:32 INFO - no previously-included directories found matching '.git*' 05:37:32 INFO - Installing collected packages: jsonschema, functools32 05:37:32 INFO - Running setup.py install for functools32 05:37:33 INFO - warning: no files found matching '*.txt' 05:37:33 INFO - no previously-included directories found matching 'build' 05:37:33 INFO - no previously-included directories found matching 'dist' 05:37:33 INFO - no previously-included directories found matching '.git*' 05:37:33 INFO - Successfully installed jsonschema functools32 05:37:33 INFO - Cleaning up... 05:37:33 INFO - Return code: 0 05:37:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:33 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 05:37:33 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 05:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:33 INFO - 'HOME': '/Users/cltbld', 05:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:33 INFO - 'LOGNAME': 'cltbld', 05:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:33 INFO - 'MOZ_NO_REMOTE': '1', 05:37:33 INFO - 'NO_EM_RESTART': '1', 05:37:33 INFO - 'PAGER': '/bin/cat', 05:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:33 INFO - 'PWD': '/builds/slave/test', 05:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:33 INFO - 'SHELL': '/bin/bash', 05:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:33 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:33 INFO - 'USER': 'cltbld', 05:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:33 INFO - 'XPC_FLAGS': '0x0', 05:37:33 INFO - 'XPC_SERVICE_NAME': '0', 05:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:37:33 INFO - Cleaning up... 05:37:33 INFO - Return code: 0 05:37:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:33 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 05:37:33 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 05:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:33 INFO - 'HOME': '/Users/cltbld', 05:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:33 INFO - 'LOGNAME': 'cltbld', 05:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:33 INFO - 'MOZ_NO_REMOTE': '1', 05:37:33 INFO - 'NO_EM_RESTART': '1', 05:37:33 INFO - 'PAGER': '/bin/cat', 05:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:33 INFO - 'PWD': '/builds/slave/test', 05:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:33 INFO - 'SHELL': '/bin/bash', 05:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:33 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:33 INFO - 'USER': 'cltbld', 05:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:33 INFO - 'XPC_FLAGS': '0x0', 05:37:33 INFO - 'XPC_SERVICE_NAME': '0', 05:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:37:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:37 INFO - Downloading docopt-0.6.1.tar.gz 05:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:37 INFO - Running setup.py install for blobuploader 05:37:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:37:37 INFO - Running setup.py install for requests 05:37:38 INFO - Running setup.py install for docopt 05:37:38 INFO - Successfully installed blobuploader requests docopt 05:37:38 INFO - Cleaning up... 05:37:38 INFO - Return code: 0 05:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:38 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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:38 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 05:37:38 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 05:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:38 INFO - 'HOME': '/Users/cltbld', 05:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:38 INFO - 'LOGNAME': 'cltbld', 05:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:38 INFO - 'MOZ_NO_REMOTE': '1', 05:37:38 INFO - 'NO_EM_RESTART': '1', 05:37:38 INFO - 'PAGER': '/bin/cat', 05:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:38 INFO - 'PWD': '/builds/slave/test', 05:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:38 INFO - 'SHELL': '/bin/bash', 05:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:38 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:38 INFO - 'USER': 'cltbld', 05:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:38 INFO - 'XPC_FLAGS': '0x0', 05:37:38 INFO - 'XPC_SERVICE_NAME': '0', 05:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-a17rFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-77ryxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-YhlWpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-g92j3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-SsOqkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-_Av9D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-b8hure-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-JHB0jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-mNpOP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-HPpZsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-0Xvg2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-UUJsP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-abe7p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-iONvPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-67AP64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:40 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-lhc1fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:40 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-4b2ZJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:40 INFO - Running setup.py install for manifestparser 05:37:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:37:40 INFO - Running setup.py install for mozcrash 05:37:40 INFO - Running setup.py install for mozdebug 05:37:40 INFO - Running setup.py install for mozdevice 05:37:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:37:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:37:40 INFO - Running setup.py install for mozfile 05:37:41 INFO - Running setup.py install for mozhttpd 05:37:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Running setup.py install for mozinfo 05:37:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Running setup.py install for mozInstall 05:37:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Running setup.py install for mozleak 05:37:41 INFO - Running setup.py install for mozlog 05:37:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Running setup.py install for moznetwork 05:37:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:37:41 INFO - Running setup.py install for mozprocess 05:37:42 INFO - Running setup.py install for mozprofile 05:37:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:37:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:37:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:37:42 INFO - Running setup.py install for mozrunner 05:37:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:37:42 INFO - Running setup.py install for mozscreenshot 05:37:42 INFO - Running setup.py install for moztest 05:37:42 INFO - Running setup.py install for mozversion 05:37:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:37:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:42 INFO - Cleaning up... 05:37:42 INFO - Return code: 0 05:37:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:42 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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:42 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 05:37:42 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 05:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:42 INFO - 'HOME': '/Users/cltbld', 05:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:42 INFO - 'LOGNAME': 'cltbld', 05:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:42 INFO - 'MOZ_NO_REMOTE': '1', 05:37:42 INFO - 'NO_EM_RESTART': '1', 05:37:42 INFO - 'PAGER': '/bin/cat', 05:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:42 INFO - 'PWD': '/builds/slave/test', 05:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:42 INFO - 'SHELL': '/bin/bash', 05:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:42 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:42 INFO - 'USER': 'cltbld', 05:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:42 INFO - 'XPC_FLAGS': '0x0', 05:37:42 INFO - 'XPC_SERVICE_NAME': '0', 05:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ip7nfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ehrba3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-fXsMKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-FWzacj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-HODsAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-dzWjqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-uY7JQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-EBkl_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:43 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)) 05:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-_6F2UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-yZl9cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-8Ce8HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-BGSQrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Q7aV8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-tX6O7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-TmsFye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-QcHl7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:44 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)) 05:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-w4Q9Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 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)) 05:37:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:44 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 05:37:44 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 05:37:44 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 05:37:44 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 05:37:44 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 05:37:44 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 05:37:47 INFO - Downloading blessings-1.6.tar.gz 05:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:47 INFO - Installing collected packages: blessings 05:37:47 INFO - Running setup.py install for blessings 05:37:47 INFO - Successfully installed blessings 05:37:47 INFO - Cleaning up... 05:37:47 INFO - Return code: 0 05:37:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:47 INFO - Reading from file tmpfile_stdout 05:37:47 INFO - Current package versions: 05:37:47 INFO - blessings == 1.6 05:37:47 INFO - blobuploader == 1.2.4 05:37:47 INFO - docopt == 0.6.1 05:37:47 INFO - functools32 == 3.2.3-2 05:37:47 INFO - jsonschema == 2.5.1 05:37:47 INFO - manifestparser == 1.1 05:37:47 INFO - mozInstall == 1.12 05:37:47 INFO - mozcrash == 0.17 05:37:47 INFO - mozdebug == 0.1 05:37:47 INFO - mozdevice == 0.48 05:37:47 INFO - mozfile == 1.2 05:37:47 INFO - mozhttpd == 0.7 05:37:47 INFO - mozinfo == 0.9 05:37:47 INFO - mozleak == 0.1 05:37:47 INFO - mozlog == 3.4 05:37:47 INFO - moznetwork == 0.27 05:37:47 INFO - mozprocess == 0.23 05:37:47 INFO - mozprofile == 0.28 05:37:47 INFO - mozrunner == 6.12 05:37:47 INFO - mozscreenshot == 0.1 05:37:47 INFO - mozsystemmonitor == 0.3 05:37:47 INFO - moztest == 0.7 05:37:47 INFO - mozversion == 1.4 05:37:47 INFO - psutil == 3.1.1 05:37:47 INFO - requests == 1.2.3 05:37:47 INFO - wsgiref == 0.1.2 05:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:47 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')]} 05:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 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')]} 05:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:47 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 05:37:47 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 05:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:47 INFO - 'HOME': '/Users/cltbld', 05:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:47 INFO - 'LOGNAME': 'cltbld', 05:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:47 INFO - 'MOZ_NO_REMOTE': '1', 05:37:47 INFO - 'NO_EM_RESTART': '1', 05:37:47 INFO - 'PAGER': '/bin/cat', 05:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:47 INFO - 'PWD': '/builds/slave/test', 05:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:47 INFO - 'SHELL': '/bin/bash', 05:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:47 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:47 INFO - 'USER': 'cltbld', 05:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:47 INFO - 'XPC_FLAGS': '0x0', 05:37:47 INFO - 'XPC_SERVICE_NAME': '0', 05:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 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)) 05:37:48 INFO - Cleaning up... 05:37:48 INFO - Return code: 0 05:37:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:48 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 0x10b14a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbe9cd8950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, '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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 05:37:48 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 05:37:48 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 05:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:48 INFO - 'HOME': '/Users/cltbld', 05:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:48 INFO - 'LOGNAME': 'cltbld', 05:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:48 INFO - 'MOZ_NO_REMOTE': '1', 05:37:48 INFO - 'NO_EM_RESTART': '1', 05:37:48 INFO - 'PAGER': '/bin/cat', 05:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:48 INFO - 'PWD': '/builds/slave/test', 05:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:48 INFO - 'SHELL': '/bin/bash', 05:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:37:48 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:48 INFO - 'USER': 'cltbld', 05:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:48 INFO - 'XPC_FLAGS': '0x0', 05:37:48 INFO - 'XPC_SERVICE_NAME': '0', 05:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:37:48 INFO - Cleaning up... 05:37:48 INFO - Return code: 0 05:37:48 INFO - Running post-action listener: _resource_record_post_action 05:37:48 INFO - Running post-action listener: _start_resource_monitoring 05:37:48 INFO - Starting resource monitoring. 05:37:48 INFO - [mozharness: 2016-10-07 12:37:48.543563Z] Finished create-virtualenv step (success) 05:37:48 INFO - [mozharness: 2016-10-07 12:37:48.544509Z] Running install step. 05:37:48 INFO - Running pre-action listener: _resource_record_pre_action 05:37:48 INFO - Running main action method: install 05:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:48 INFO - Reading from file tmpfile_stdout 05:37:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:37:48 INFO - Reading from file tmpfile_stdout 05:37:48 INFO - Output received: 05:37:48 INFO - Usage: mozinstall [options] installer 05:37:48 INFO - Options: 05:37:48 INFO - -h, --help show this help message and exit 05:37:48 INFO - -d DEST, --destination=DEST 05:37:48 INFO - Directory to install application into. [default: 05:37:48 INFO - "/builds/slave/test"] 05:37:48 INFO - --app=APP Application being installed. [default: firefox] 05:37:48 INFO - mkdir: /builds/slave/test/build/application 05:37:48 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'] 05:37:48 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 05:38:21 INFO - Reading from file tmpfile_stdout 05:38:21 INFO - Output received: 05:38:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:38:21 INFO - Running post-action listener: _resource_record_post_action 05:38:21 INFO - [mozharness: 2016-10-07 12:38:21.604640Z] Finished install step (success) 05:38:21 INFO - [mozharness: 2016-10-07 12:38:21.604775Z] Running run-tests step. 05:38:21 INFO - Running pre-action listener: _resource_record_pre_action 05:38:21 INFO - Running main action method: run_tests 05:38:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:21 INFO - 2016-10-07 05:38:21.618 screenresolution[1660:7492] starting screenresolution argv=screenresolution get 05:38:21 INFO - 2016-10-07 05:38:21.621 screenresolution[1660:7492] Display 0: 1600x1200x32@60 05:38:21 INFO - 2016-10-07 05:38:21.627 screenresolution[1661:7494] starting screenresolution argv=screenresolution list 05:38:21 INFO - Available Modes on Display 0 05:38:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:21 INFO - Intel Iris: 05:38:21 INFO - Chipset Model: Intel Iris 05:38:21 INFO - Type: GPU 05:38:21 INFO - Bus: Built-In 05:38:21 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:21 INFO - Vendor: Intel (0x8086) 05:38:21 INFO - Device ID: 0x0a2e 05:38:21 INFO - Revision ID: 0x0009 05:38:21 INFO - Displays: 05:38:21 INFO - Display: 05:38:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:21 INFO - Display Serial Number: 1600x1200 60 05:38:21 INFO - Main Display: Yes 05:38:21 INFO - Mirror: Off 05:38:21 INFO - Online: Yes 05:38:21 INFO - Rotation: Supported 05:38:21 INFO - Return code: 0 05:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:21 INFO - Python 2.7.3 05:38:21 INFO - Return code: 0 05:38:21 INFO - grabbing minidump binary from tooltool 05:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:21 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 0x10af5ed30>, '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 0x10adc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af56b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:21 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 05:38:21 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 05:38:21 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 05:38:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:21 INFO - Return code: 0 05:38:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:38:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:38:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHeyLDgSDd/Render', 05:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:21 INFO - 'HOME': '/Users/cltbld', 05:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:21 INFO - 'LOGNAME': 'cltbld', 05:38:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:21 INFO - 'MOZ_NO_REMOTE': '1', 05:38:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:21 INFO - 'NO_EM_RESTART': '1', 05:38:21 INFO - 'PAGER': '/bin/cat', 05:38:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:21 INFO - 'PWD': '/builds/slave/test', 05:38:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:21 INFO - 'SHELL': '/bin/bash', 05:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Buf8gQV4yN/Listeners', 05:38:21 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 05:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:21 INFO - 'USER': 'cltbld', 05:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:21 INFO - 'XPC_FLAGS': '0x0', 05:38:21 INFO - 'XPC_SERVICE_NAME': '0', 05:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:38:22 INFO - mozversion application_buildid: 20161007033200 05:38:22 INFO - mozversion application_changeset: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 05:38:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:38:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:22 INFO - mozversion application_name: Firefox 05:38:22 INFO - mozversion application_remotingname: firefox-dev 05:38:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:38:22 INFO - mozversion application_vendor: Mozilla 05:38:22 INFO - mozversion application_version: 51.0a2 05:38:22 INFO - mozversion platform_buildid: 20161007033200 05:38:22 INFO - mozversion platform_changeset: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 05:38:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:38:22 INFO - mozversion platform_version: 51.0a2 05:38:22 INFO - using testdate: 1475843902 05:38:22 INFO - actual date: 1475843902 05:38:22 INFO - starting webserver on 'localhost:49272' 05:38:22 INFO - SUITE-START | Running 2 tests 05:38:22 INFO - TEST-START | dromaeo_css 05:38:22 INFO - operating with platform_type : mac_ 05:38:22 INFO - Initialising browser for dromaeo_css test... 05:38:22 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpqAa0Tu/profile http://localhost:49272/getInfo.html) 05:38:25 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 05:38:25 INFO - PROCESS | 1671 | colorDepth:24 05:38:25 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 05:38:25 INFO - PROCESS | 1671 | __metrics 05:38:25 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 05:38:25 INFO - TEST-INFO | 1671: exit 0 05:38:25 INFO - Browser initialized. 05:38:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:25 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpqAa0Tu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:37 INFO - PROCESS | 1675 | RSS: Main: 224591872 05:38:37 INFO - PROCESS | 1675 | 05:39:27 INFO - PROCESS | 1675 | 1475843967483 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] 05:41:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:41:41 INFO - PROCESS | 1675 | RSS: Main: 236515328 05:41:41 INFO - PROCESS | 1675 | 05:44:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:44:44 INFO - PROCESS | 1675 | RSS: Main: 247783424 05:44:44 INFO - PROCESS | 1675 | 05:47:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:47:47 INFO - PROCESS | 1675 | RSS: Main: 250126336 05:47:47 INFO - PROCESS | 1675 | 05:50:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:50:49 INFO - PROCESS | 1675 | RSS: Main: 251613184 05:50:49 INFO - PROCESS | 1675 | 05:53:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:53:53 INFO - PROCESS | 1675 | RSS: Main: 256749568 05:53:53 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:56:55 INFO - PROCESS | 1675 | RSS: Main: 258703360 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | __start_tp_report 05:56:55 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:56:55 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:56:55 INFO - PROCESS | 1675 | |i|pagename|runs| 05:56:55 INFO - PROCESS | 1675 | |0;dojo.html;3037.756979441645;3366.6128395234546;3465.4108801503758;3472.3228970350774;3479.8608055677773;5796.3044434667845;5868.85327866803;5882;5885.852853678655;5901.527877769779;5830.970845145768;5877.3241077276125;5921.407859214087;5921.970390148043;5931.584789064767;5287.47125287471;5348.384935732402;5380.488853558905;5389.541888939445;5393.164059570753;5371.086915224421;5384.623076384654;5388.110961691316;5396;5454.863628409302;5256.92114618281;5275.182346736262;5364.383095943977;5367.812126575571;5373.785048598071;4362.432883725111;5304.549113325372;5304.840854774363;5310.097283461821;5380.381256155514;5243.501867322599;5269.815556455544;5279.973600131974;5368.812091576776;5388.299521062237;4809.350737650442;4979.850604481835;5780.797672081457;5925.081612350093;5975.910361344583;4915.852524424273;5723.198752174699;6205.534584906105;6228.159198508189;6248.937510624926;6223.533235007392;6262.937370626281;6267.341929097471;6294.118823364733;6309.432151106423;5935.643861368331;5945.554083443759;5965.045592705146;5984.042553191469;6032.034874420159;6254.155688981929;6285.151504546828;6341.746330146742;6346.048092786026;6357.745690172342;6282.748690052438;6290.402411770874;6303.3066362700065;6312.842178945563;6330.873382532323;6327.145835312174;6328.208973878265;6341.841453963595;6345.270293916259;6362.77730279438;6142.253225532421;6194.721237544321;6231.158793562901;6259.280182778948;6265.937340626535;5746.109353050284;6260.624362538262;6284.717187726564;6296.024116261987;6324.747010119636;4506.684532082788;4981.501849815062;5041.823536176216;5043.722595257223;5053.140966035783;4401.361802538614;4439.955600444019;4444.688871779009;4474.731516109044;4531.43357080365;6016.1878146450545;6054.757809687651;6058.757649693963;6089.995150800069;6099.359567245464;6268.404501572343;6309.526785491014;6314.652694101868;6325.557210995186;6330.683465826783;5865.853353666193;5932.110183472513;5937.614055086492;5975.163477113208;6045.909311360333;5445.564354851603;5471.50756431915;5490.341159060858;5532.695701736443;5533.750981205855;6487.448566871869;6537.313582073813;6558.376954189344;6561.967190164019;6570.244421891448;6294.4964402846745;6331.746730130743;6361.427471527585;6362.840928976812;6370.140031095742;6282.340354262919;6333.461655759312;6406.807795766134;6459.709313081016;6556.573822701509;6278.215223097113;6301.6219026858535;6308.936910630835;6314;6337.334579869047;6295.087212354275;6339.112524246517;6341.048842673451;6363.459105976044;6381.680915954276;4997.925031124463;6091.543134264859;6198.101275315144;6280.246370435577;6300.7479700811455;6178.289496707936;6245.843853903689;6252.374762523893;6272;6319.842003949754;5174.896502069862;6200.255969283715;6204.348543402878;6219.346968568235;6266.530010249158;6108.908366374597;6153.630782153085;6219.813405597839;6241.316980624606;6286.308506064238;6105.725242364193;6111.174991376108;6114.052321890114;6163.19878415803;6182 05:56:55 INFO - PROCESS | 1675 | |1;ext.html;448.90124172682;466.5777471388391;485.3060124022646;495.3362494257694;525.0234563711497;32080;41939.58060419399;42000.57999420005;42319;42377.364339534855;43707.562924370744;43787.34318985218;43858;43950;44176;8921.509316987564;9203.631854725803;9872.308938374317;9875.456849873253;9912.504374781269;9738.464384458852;9809.558569864374;9850.458224797634;9875.1112399884;9890.30767846251;9838.606455741798;9894.356866803635;9902.603895844193;9908;9939.552720127576;9807.215422766161;9852.261080418997;9858.556364963593;9882.703518894445;9886.505674716307;9756.4633945133;9790.608375664964;9791;9828.164606008499;9873.60505579776;40675;40756;40758;41000.58999410027;41079.58920410788;3186.4583020886275;3339.0650617827046;3501.124718820295;3682.668559829628;3717.312297225022;31448.213794655087;31481.527777083364;31554.526682099786;31648;32686;3159.3997140543224;3216.485362342014;3241.3679332530164;3248.902532924016;3259.429599820022;444113;445281;446123;447700.99999999674;447902;33637.82267620622;60116.39883601108;60259.79480410367;60546;60601.696991515644;34127.48808767871;34788.652113479046;35282.470762938574;35319.64680353215;35449.82275088608;14744.41022359115;14822.332995015251;14939.626509337353;14961.40154393812;14967.700645987237;12509.812352814715;12684.556040538722;12792.744145117045;12793;12793.808092878615;7399.334059934632;7668.271514206142;7731.420143489261;7746.457747957702;7752.186020467882;3167.904962851118;3226.935461290761;3227.564278822376;3235.3470154473575;3250.6424293327714;892.6875593542338;913.2283220678516;975.707287813653;982.4350998176077;983.1102851919024;25294.87352563262;29584.55623165654;29604.815807367893;30712.53931191034;31031;1018.9847152292722;1025.0825511167463;1071.5553045486192;1083.5990683447176;1101.1191047162238;15206.771898421532;15231.695505876027;15280.930334876452;15307.234638268043;15563.610909727347;698211;700323;700748;702381;702610;56346.43653563412;56663;56756.43243567594;57022.7148864253;57342.7132864333;1352.4049418255936;1360.2722543439213;1384.5707830572555;1386.202933313349;1386.9098508596908;28563.28591785222;28905.710942890302;29503.96736114226;29727.851360743058;30089.645965932024;50051.749741251064;50685.23972140347;50746;50913;51115.233271501704;643053;646278;648435;648546;649519;21645.567088658452;21879.67180492326;23671.408214794767;25413.364665883502;26538.80575374074;47033.58899233028;47503.762481187376;47711.76144119396;48124.037519250116;48997.02005959932;39602;39990.600328988345;40950.385744213265;41495;41778.79110604428;39873.60126398699;39937.00157496086;39942.00289985547;40590.79704601458;40763.59236407598;33594.832025839714;33603;36719.81640091782;39082;39185.020374490865;32841.67158328386;35082.772102976276;35253.82373088118;35470.46794298036;35717;23171.884140579863;24277.271681849572;26118.608220876322;26313.73686263113;26613.866930665223 05:56:55 INFO - PROCESS | 1675 | |2;jquery.html;341.1641478377974;376.5631867034241;380.45594799436805;381.03217826720135;403.01462923152883;19637.312694055712;20322.085506152223;20631.381058568248;21046.89476552615;21187;19969.10139043743;20223.696644550342;20359.38921832344;20438.08028638711;20631.865247411424;4820.084184005045;5172.27588137661;5790.71046447677;5969.701514924258;6057.969710151443;5886.470217680408;5978.402159784008;5984.820455386345;6000.399960004008;6007.4593286604195;5605.383407825136;5840.707964601774;5853.707314634273;5857.85355366115;5937.22816033915;5568.972155139199;5728.3698793132935;5759.136129580555;5810.24466819315;5833.824985250428;5084.9745751271375;5088.643794934356;5110.977804439127;5118.334616499868;5131.615128865313;25278.873605632038;25291.494170116493;25392.238232853044;25452.36369090769;25567.23298301054;1991.9302824401077;2383.475635360218;2562.7821635161035;2566.140342985102;2622.8557429341377;9707.466089365082;10257;10447.68656940293;14836;14881.18153501557;1524.7941527893704;1878.3519685708409;1923;1930.6428310762412;1949.064449064457;90715;123428.38285808514;129706;130492;131066;11413.771724565462;11561;11770.58802941893;11929.224600400947;12026.218295810744;12121;14400.495982640557;14500.927495362455;14517.201553914636;14544.854551454562;8320.635585175469;8616.267617252479;8652.956735216283;8725.52009639476;8796.736097917073;8559.572021398904;8668.263197628146;8686.218240358272;8789;8813.383063185644;4418.359337896051;4476.037651904791;4505.594496495266;4512.684112112186;4568.309725401623;1929.2668785861283;1966.3314473079222;1968.5964377302619;1976.40707787666;2014.869033512817;818.8812622169871;878.7495563764296;884.9247813935759;957.8563215517728;988.9011098890197;16487.34050637961;20261.088251028737;20278.290259840836;21038;21200.575988480145;769.342212408394;895.583553647557;939.6288466056006;941.1482608239554;988.5946761827616;8309.875351869727;9184.448933064037;11087.889121108847;11100;11141.053010494199;562912;566299;567545;589305;607783;130448;130717.69282307246;134970;138547;138668;831.7837362285849;942.58997336159;944.3436811416137;972.1979367022235;973.8685277487449;18195.45413637593;18553.35063272779;18819.341323053628;18911.71632425487;19042.19099185575;23596.056157754185;35611;47841.76079119582;51112;52955;73130.54499366294;75419;79138;79285.60357198177;79596.60201698955;7878.054633444023;7980.521168729895;8059.919400806151;8181.304589109992;8258.710945116893;12076.706642986737;12729.872701272869;13079.738405231652;13146.145500542434;13227.206367617973;10927;10954.233203675667;11062.834057489305;11328.263662861887;11386.146039047271;10042.347247428894;10305.227107966783;10662.626808061681;10989.835152472559;11011;11102.944485277521;11317.660470185907;11599.478023489131;11625.709357265798;11641.59254426091;7958.363330933395;8000.559969201517;8255.917440825755;8353.457025293337;8432.45189062709;8812.603432845666;10825.296355736851;10951.233413660968;11112.722181945515;11224.214304998899 05:56:55 INFO - PROCESS | 1675 | |3;mootools.html;1348.4740951029098;1499.2578673556588;1663.176727519877;1835.0549467024478;1848.639515294518;7941.16617755136;8204.466709663868;8491.957540212297;8955.417897836636;8975.506347150913;8500.78748031298;8758.34312426569;8787.95606021969;8866.689665861697;8878.112188781135;2410.7348191698943;2427.4538228898446;2428.8178386621075;2430.890609922558;2435.9878200608973;2422;2437.195725410619;2437.792787613055;2439.634054891763;2450.571150048743;2390.689210402645;2400.7959323457526;2424.1757802347197;2425.514897020594;2438.2685194441683;2099.6745504446835;2400.2679182849224;2409.554232466999;2420.056178090546;2422.019082271665;2394.2817154853647;2399.808015358767;2405.110109259585;2406.338256979327;2412.3124909400913;8689.739307820775;8710.128987101303;8811.295096392338;8814.162654547808;8894.644214231488;5220.216967454874;5348.705821179834;5365.195220716884;5365.597580181463;5367.355917289911;3520.7887526748477;3666.7249956253386;3696.815159242027;3711.9814400928094;3765.3975363941913;1080.5623722392443;1101.5373543111912;1107.8227483602666;1120.3501968858043;1125.7073160978123;11606.129540284512;11663.883361166365;11687.649370518813;11699.649010529612;11701.414929253504;4562.110388474282;4743.980044290494;4823.758812059383;4829.9034019319415;4879.2925025871045;9809.607615695435;9854.802903942025;9889.159421449114;9940.701778946643;9955.651552195639;5336.306280183551;5337.092694241988;5357.383900851374;5359.330083739533;5367.731613419392;4414.293713005904;4519.638428925744;4699.177643912301;4850.078485087822;5006.949930500648;3451.5685539307588;3964.8215830287704;3970.861019864291;4031.8387264509092;4098;1307.1176955554963;1318.65714914123;1320.973580528384;1324.9403776830065;1326.6550696818704;776.5534817479971;860.8450478913855;894.2130924786146;906.1708536688856;912.9863052054225;4871.318015477836;5609.4390560943575;5623.8594035149445;5729.656220626775;6000.309964354068;749.8087987563136;896.9730908072638;912.7489940266347;932.664240873285;965.4207475514635;3330.766846320783;3816.656500914931;3926.8429262829736;3959.9802000990385;4017.4777278953547;9469.532222505522;9955.80088398228;10147.898521014695;10629.787404252027;10717.78564428707;9005.549722513848;10449.895501044892;10495.212859035602;10518.526666300035;10519.421431821323;7907.0906845712325;7925.286724194735;8175.305099066527;8187.71343002992;8236.876446853303;5768.278965129359;5845.444682755132;5871.7651293949475;6023.30731965812;6092.268927728701;9767.511624418608;9821.459819709984;9884.25868059884;9975.052370024836;10004.499775011074;9527.714168574954;9989.150922171697;10130.544125514516;10274.589016439259;10421.583136674448;8126.83746325082;8256.711015114442;8290.46112002718;8304.87542686848;8379.162083791573;8202.712905048294;8256.628451719567;8320.37597180226;8331.6667333306;8332.875006875023;7227.7831665050135;7420.072490938633;7486.812829679302;7560.168381478143;7563.9621801890635;7251.20236773965;7253.637318133967;7298.343149116605;7359.668814903235;7463.104427468738;6783.525153239226;6938.167419909643;6941.791746247621;6984.441244700513;7038.929610703827;4816.494268101939;4861.1006963710415;4979;4986.376702912136;5136.589072874086;4973.9306049199595;5033.924491132562;5223.399309079353;5232.555232805102;5257.921131183112 05:56:55 INFO - PROCESS | 1675 | |4;prototype.html;278.91493094606165;280.7150741996873;311.1877998424113;314.0562609358876;314.69946201377684;5212.504812042859;5345.7594408251725;5404.8919021619595;5465.863353416162;5493.615446918718;4447.3773671685985;5091.898162036757;5147.922781158286;5195.636305458619;5419.458054194589;3439.518467414564;4122.711894898338;4123.587641235882;4140.089180380327;4140.834366625331;3613.5663720353596;3657.7988210648405;4124.401961715549;4152.5432202457705;4160.583941605831;3043.5434684797347;3436.0379093853635;4094.9590504095027;4128.669706423479;4199.916001679964;3722.758020728644;3795.7532760370764;4084.2852500812237;4106.425100485934;4121.8969525761795;3578.7673801202836;3585.5836944407074;3585.910352241189;3589.2900859850647;3620.475031120499;4918.2376731606655;4948.777305021283;5263.342047255102;5263.605229607795;5276.630635855492;3609.5127157833617;4689.437267527885;4715;4715.622750180011;4727.905441891177;4738.218193997986;5655.575831812631;5722.509269345695;5747.298769578333;5956.344802071769;3774.622537746231;3904.4728961590104;3928.7035278358358;3966.484357033596;4020.9195816083516;5470.398256191816;5503.6147469677135;6041.154238406627;6042.637441753509;6087.239095113111;3859.3632050711317;3987.003249187703;4012.6789856811383;4027.2750904836826;4028.2346354193196;3667.3215455140885;3668.486411902336;3973.6026397360033;4069.3895915612893;4079;4606.700564463299;4635.559621835921;4641.976790116028;4665.883352916204;4692.4603670577635;5222.608304377187;5723.427657234327;5735.942640573541;5800.53595712342;5824.767009319665;1017.3692310767372;1164.5865717670274;1174.8942595166477;1245.8318127052912;1266;844.3709436469869;844.7507985144397;899.7570655922864;906.1753804038425;906.7803803883766;4206.810693518738;4339.82640694375;4598.356230127785;5050.823221187241;5275.287836142148;4892.3884514435695;5787.88424231513;5820.912686309709;5829.446202610745;5837.416258374129;4498.66907714353;4607.35497030416;4988.276699878497;5274.129768588216;5298.496642818926;3082.892098776532;3145.9685403145677;3148.826814525223;3177.4121787469394;3177.7140057394945;5428.200259818143;5930.703464826742;6240.937590624127;6258.968705156445;6311.053341998737;5047.520485553867;5254.579633629301;5762.279715035621;6171.506279497629;6260.780872669526;5270.973645131749;5276.709780962084;5584.636998595079;6323.4625056868845;6360.332165122595;5776.458358322493;5824.94175058244;5996.67018313997;6056.818295451144;6092.238470191226;4853.733044682435;4929.767558110472;5750.62620929655;6028.4272994065495;6047.395260473917;5435.918461223006;6185.226846644169;6320.873582528416;6343.777967771106;6375.855693799068;3470.670286322795;3818.4845045918446;3927.2145570885364;4033.1933613276874;4084.407760874716;5204.765785539736;5345.599080068932;5511.8149597836655;5565.499105080562;5939.910901336397;4748.836535048935;4785.808567657255;5578.967890940189;5776.537876969916;5900.822975310747;4612.30815377696;5884.705764711662;5929.762809487745;5933.732982015906;5963.344032156546;5145.331106956071;5505.311836020497;5698.230738850202;5781.335146458211;5800.4489573490455;5359.437259087739;5394.002109609734;5498.202760599611;5772.6536407815665;5805.680687562224;5479.53423958952;5656.943430565641;5688.459596338506;5709.773188456422;5726.627769194989 05:56:55 INFO - PROCESS | 1675 | |5;yui.html;693.6566399632179;726.4914559808129;755.440973679477;799.1848314718986;807.6284908941889;15296.31166597503;15710.135942523157;15720.292586833591;15775.447859324926;15804.209789510522;14123.858761412383;14143.646408839784;14146.858531414682;14155.009149359548;14224.502142425017;651.5862427358614;670.0351493848866;811.059171361221;821.2198411509061;840.8444437779;834.9540775257359;835.031363618203;835.8453686068096;837.4389159263308;839.630562552475;878.8813510176109;888.7555922121436;890.0921060518267;892.7857314244567;893.3835653399166;853.63293783673;877.2236570635002;882.307388699874;882.5013867165063;883.4434306387;662.6521076434863;662.6752891083382;664.050407916679;665.8501837086665;666.5167753378762;15065.849341506555;15066.020708653903;15076.170810605412;15105.848941510554;15108.54674359771;14563.563093107225;14788.334524946404;14816;14885.404583816635;14888.702225955529;11737.237079589799;11929.522819087226;12139.96810271128;12188.634340969786;12298.139130260884;3788.2234142000825;3806.885793426202;3823.9617603823885;3838.42423636454;3876.089119057019;78617.60691196508;90789;121037;121085;126313.10530342053;11003.669889903316;11082.058025067798;11129.666110016713;11267.943660281646;11486.483108260149;21398.679019814714;21691.91540423004;21729;21879.781202187773;22050.44873878134;8171.959140204261;8184.099749027602;8214.63034163464;8218.794530136674;8340.791480213044;4303.978480107579;4386.2224057554395;4532.546745325441;4567.269236922143;4573.611243044378;3626.637336266405;3752.137008488063;3759.586445490994;3760.191558814813;3784;629.1537881549309;687.0552989639247;690.4890381117937;691.3708525242106;713.6182142553813;548.3173449055871;588.5350573047331;660.9074729537869;664.4020381656451;672.3881268046055;8706.782330441789;9676.56455459506;9736.853947190797;9856.802863942825;9911.702648920544;532.6484520216638;632.2476253258608;656.7668477690447;664.9401553860176;667.5961043568668;4197.391378250137;4682.4381074271305;4695.483496815347;4779.522047795263;4808.831690890802;166591.167044164;167736;168594;168927;173871;72152;73961.6301918487;143542;150620;152262;103435.48282258691;108686.45656771665;108918.99999999841;113195;115191;9625.951870240604;9836.999715086968;9872.325121381231;9880.802383952425;9930.652427165014;64114;64178;65000.349996499426;65905.67047164733;66870.3312966864;93959.59060614233;98781.01218987718;100294;102343.48828255812;103450.48274758577;10317.793644126925;12352.814707779571;12659.556915507914;12741.853233209056;12987.960963122738;13945.930270348583;14054.227017513726;14354.569362919128;14428.567142985727;14470.927645361706;12851.228926264454;13634.181949083088;13649.931750341184;14181;14193.290335482978;13051.21692698441;13359.666008349868;13564.137849102603;13741.862581374058;13930.791038134234;12739.61781146567;13045.695430457257;13287.534936277183;13887.166769993833;14031.508897188549;10719.678409647722;10978.341299522055;11504.53981840717;11690.88309116898;11871.050315974873;9322.300827437834;11006.119510439306;11474.94262528682;11505.446764686994;11620.360880151335 05:56:55 INFO - PROCESS | 1675 | __end_tp_report 05:56:55 INFO - PROCESS | 1675 | __start_cc_report 05:56:55 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,358 05:56:55 INFO - PROCESS | 1675 | __end_cc_report 05:56:55 INFO - PROCESS | 1675 | __startTimestamp1475845015929__endTimestamp 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:56:55 INFO - PROCESS | 1675 | Number of tests: 6 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5828.81 Median:6108.91 stddev:681.83 (11.2%) stddev-sans-first:647.81 05:56:55 INFO - PROCESS | 1675 | Values: 3037.8 3366.6 3465.4 3472.3 3479.9 5796.3 5868.9 5882.0 5885.9 5901.5 5831.0 5877.3 5921.4 5922.0 5931.6 5287.5 5348.4 5380.5 5389.5 5393.2 5371.1 5384.6 5388.1 5396.0 5454.9 5256.9 5275.2 5364.4 5367.8 5373.8 4362.4 5304.5 5304.8 5310.1 5380.4 5243.5 5269.8 5280.0 5368.8 5388.3 4809.4 4979.9 5780.8 5925.1 5975.9 4915.9 5723.2 6205.5 6228.2 6248.9 6223.5 6262.9 6267.3 6294.1 6309.4 5935.6 5945.6 5965.0 5984.0 6032.0 6254.2 6285.2 6341.7 6346.0 6357.7 6282.7 6290.4 6303.3 6312.8 6330.9 6327.1 6328.2 6341.8 6345.3 6362.8 6142.3 6194.7 6231.2 6259.3 6265.9 5746.1 6260.6 6284.7 6296.0 6324.7 4506.7 4981.5 5041.8 5043.7 5053.1 4401.4 4440.0 4444.7 4474.7 4531.4 6016.2 6054.8 6058.8 6090.0 6099.4 6268.4 6309.5 6314.7 6325.6 6330.7 5865.9 5932.1 5937.6 5975.2 6045.9 5445.6 5471.5 5490.3 5532.7 5533.8 6487.4 6537.3 6558.4 6562.0 6570.2 6294.5 6331.7 6361.4 6362.8 6370.1 6282.3 6333.5 6406.8 6459.7 6556.6 6278.2 6301.6 6308.9 6314.0 6337.3 6295.1 6339.1 6341.0 6363.5 6381.7 4997.9 6091.5 6198.1 6280.2 6300.7 6178.3 6245.8 6252.4 6272.0 6319.8 5174.9 6200.3 6204.3 6219.3 6266.5 6108.9 6153.6 6219.8 6241.3 6286.3 6105.7 6111.2 6114.1 6163.2 6182.0 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:71380.24 Median:40760.80 stddev:163274.37 (400.6%) stddev-sans-first:163645.54 05:56:55 INFO - PROCESS | 1675 | Values: 448.9 466.6 485.3 495.3 525.0 32080.0 41939.6 42000.6 42319.0 42377.4 43707.6 43787.3 43858.0 43950.0 44176.0 8921.5 9203.6 9872.3 9875.5 9912.5 9738.5 9809.6 9850.5 9875.1 9890.3 9838.6 9894.4 9902.6 9908.0 9939.6 9807.2 9852.3 9858.6 9882.7 9886.5 9756.5 9790.6 9791.0 9828.2 9873.6 40675.0 40756.0 40758.0 41000.6 41079.6 3186.5 3339.1 3501.1 3682.7 3717.3 31448.2 31481.5 31554.5 31648.0 32686.0 3159.4 3216.5 3241.4 3248.9 3259.4 444113.0 445281.0 446123.0 447701.0 447902.0 33637.8 60116.4 60259.8 60546.0 60601.7 34127.5 34788.7 35282.5 35319.6 35449.8 14744.4 14822.3 14939.6 14961.4 14967.7 12509.8 12684.6 12792.7 12793.0 12793.8 7399.3 7668.3 7731.4 7746.5 7752.2 3167.9 3226.9 3227.6 3235.3 3250.6 892.7 913.2 975.7 982.4 983.1 25294.9 29584.6 29604.8 30712.5 31031.0 1019.0 1025.1 1071.6 1083.6 1101.1 15206.8 15231.7 15280.9 15307.2 15563.6 698211.0 700323.0 700748.0 702381.0 702610.0 56346.4 56663.0 56756.4 57022.7 57342.7 1352.4 1360.3 1384.6 1386.2 1386.9 28563.3 28905.7 29504.0 29727.9 30089.6 50051.7 50685.2 50746.0 50913.0 51115.2 643053.0 646278.0 648435.0 648546.0 649519.0 21645.6 21879.7 23671.4 25413.4 26538.8 47033.6 47503.8 47711.8 48124.0 48997.0 39602.0 39990.6 40950.4 41495.0 41778.8 39873.6 39937.0 39942.0 40590.8 40763.6 33594.8 33603.0 36719.8 39082.0 39185.0 32841.7 35082.8 35253.8 35470.5 35717.0 23171.9 24277.3 26118.6 26313.7 26613.9 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:34420.28 Median:1482.01 stddev:97094.69 (6551.6%) stddev-sans-first:97333.34 05:56:55 INFO - PROCESS | 1675 | Values: 341.2 376.6 380.5 381.0 403.0 19637.3 20322.1 20631.4 21046.9 21187.0 19969.1 20223.7 20359.4 20438.1 20631.9 4820.1 5172.3 5790.7 5969.7 6058.0 5886.5 5978.4 5984.8 6000.4 6007.5 5605.4 5840.7 5853.7 5857.9 5937.2 5569.0 5728.4 5759.1 5810.2 5833.8 5085.0 5088.6 5111.0 5118.3 5131.6 25278.9 25291.5 25392.2 25452.4 25567.2 1991.9 2383.5 2562.8 2566.1 2622.9 9707.5 10257.0 10447.7 14836.0 14881.2 1524.8 1878.4 1923.0 1930.6 1949.1 90715.0 123428.4 129706.0 130492.0 131066.0 11413.8 11561.0 11770.6 11929.2 12026.2 12121.0 14400.5 14500.9 14517.2 14544.9 8320.6 8616.3 8653.0 8725.5 8796.7 8559.6 8668.3 8686.2 8789.0 8813.4 4418.4 4476.0 4505.6 4512.7 4568.3 1929.3 1966.3 1968.6 1976.4 2014.9 818.9 878.7 884.9 957.9 988.9 16487.3 20261.1 20278.3 21038.0 21200.6 769.3 895.6 939.6 941.1 988.6 8309.9 9184.4 11087.9 11100.0 11141.1 562912.0 566299.0 567545.0 589305.0 607783.0 130448.0 130717.7 134970.0 138547.0 138668.0 831.8 942.6 944.3 972.2 973.9 18195.5 18553.4 18819.3 18911.7 19042.2 23596.1 35611.0 47841.8 51112.0 52955.0 73130.5 75419.0 79138.0 79285.6 79596.6 7878.1 7980.5 8059.9 8181.3 8258.7 12076.7 12729.9 13079.7 13146.1 13227.2 10927.0 10954.2 11062.8 11328.3 11386.1 10042.3 10305.2 10662.6 10989.8 11011.0 11102.9 11317.7 11599.5 11625.7 11641.6 7958.4 8000.6 8255.9 8353.5 8432.5 8812.6 10825.3 10951.2 11112.7 11224.2 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5702.94 Median:5227.98 stddev:3153.44 (60.3%) stddev-sans-first:3145.30 05:56:55 INFO - PROCESS | 1675 | Values: 1348.5 1499.3 1663.2 1835.1 1848.6 7941.2 8204.5 8492.0 8955.4 8975.5 8500.8 8758.3 8788.0 8866.7 8878.1 2410.7 2427.5 2428.8 2430.9 2436.0 2422.0 2437.2 2437.8 2439.6 2450.6 2390.7 2400.8 2424.2 2425.5 2438.3 2099.7 2400.3 2409.6 2420.1 2422.0 2394.3 2399.8 2405.1 2406.3 2412.3 8689.7 8710.1 8811.3 8814.2 8894.6 5220.2 5348.7 5365.2 5365.6 5367.4 3520.8 3666.7 3696.8 3712.0 3765.4 1080.6 1101.5 1107.8 1120.4 1125.7 11606.1 11663.9 11687.6 11699.6 11701.4 4562.1 4744.0 4823.8 4829.9 4879.3 9809.6 9854.8 9889.2 9940.7 9955.7 5336.3 5337.1 5357.4 5359.3 5367.7 4414.3 4519.6 4699.2 4850.1 5006.9 3451.6 3964.8 3970.9 4031.8 4098.0 1307.1 1318.7 1321.0 1324.9 1326.7 776.6 860.8 894.2 906.2 913.0 4871.3 5609.4 5623.9 5729.7 6000.3 749.8 897.0 912.7 932.7 965.4 3330.8 3816.7 3926.8 3960.0 4017.5 9469.5 9955.8 10147.9 10629.8 10717.8 9005.5 10449.9 10495.2 10518.5 10519.4 7907.1 7925.3 8175.3 8187.7 8236.9 5768.3 5845.4 5871.8 6023.3 6092.3 9767.5 9821.5 9884.3 9975.1 10004.5 9527.7 9989.2 10130.5 10274.6 10421.6 8126.8 8256.7 8290.5 8304.9 8379.2 8202.7 8256.6 8320.4 8331.7 8332.9 7227.8 7420.1 7486.8 7560.2 7564.0 7251.2 7253.6 7298.3 7359.7 7463.1 6783.5 6938.2 6941.8 6984.4 7038.9 4816.5 4861.1 4979.0 4986.4 5136.6 4973.9 5033.9 5223.4 5232.6 5257.9 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:4608.63 Median:5171.78 stddev:1449.83 (28.0%) stddev-sans-first:1417.01 05:56:55 INFO - PROCESS | 1675 | Values: 278.9 280.7 311.2 314.1 314.7 5212.5 5345.8 5404.9 5465.9 5493.6 4447.4 5091.9 5147.9 5195.6 5419.5 3439.5 4122.7 4123.6 4140.1 4140.8 3613.6 3657.8 4124.4 4152.5 4160.6 3043.5 3436.0 4095.0 4128.7 4199.9 3722.8 3795.8 4084.3 4106.4 4121.9 3578.8 3585.6 3585.9 3589.3 3620.5 4918.2 4948.8 5263.3 5263.6 5276.6 3609.5 4689.4 4715.0 4715.6 4727.9 4738.2 5655.6 5722.5 5747.3 5956.3 3774.6 3904.5 3928.7 3966.5 4020.9 5470.4 5503.6 6041.2 6042.6 6087.2 3859.4 3987.0 4012.7 4027.3 4028.2 3667.3 3668.5 3973.6 4069.4 4079.0 4606.7 4635.6 4642.0 4665.9 4692.5 5222.6 5723.4 5735.9 5800.5 5824.8 1017.4 1164.6 1174.9 1245.8 1266.0 844.4 844.8 899.8 906.2 906.8 4206.8 4339.8 4598.4 5050.8 5275.3 4892.4 5787.9 5820.9 5829.4 5837.4 4498.7 4607.4 4988.3 5274.1 5298.5 3082.9 3146.0 3148.8 3177.4 3177.7 5428.2 5930.7 6240.9 6259.0 6311.1 5047.5 5254.6 5762.3 6171.5 6260.8 5271.0 5276.7 5584.6 6323.5 6360.3 5776.5 5824.9 5996.7 6056.8 6092.2 4853.7 4929.8 5750.6 6028.4 6047.4 5435.9 6185.2 6320.9 6343.8 6375.9 3470.7 3818.5 3927.2 4033.2 4084.4 5204.8 5345.6 5511.8 5565.5 5939.9 4748.8 4785.8 5579.0 5776.5 5900.8 4612.3 5884.7 5929.8 5933.7 5963.3 5145.3 5505.3 5698.2 5781.3 5800.4 5359.4 5394.0 5498.2 5772.7 5805.7 5479.5 5656.9 5688.5 5709.8 5726.6 05:56:55 INFO - PROCESS | 1675 | 05:56:55 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:25423.17 Median:3759.89 stddev:41664.87 (1108.1%) stddev-sans-first:41740.37 05:56:55 INFO - PROCESS | 1675 | Values: 693.7 726.5 755.4 799.2 807.6 15296.3 15710.1 15720.3 15775.4 15804.2 14123.9 14143.6 14146.9 14155.0 14224.5 651.6 670.0 811.1 821.2 840.8 835.0 835.0 835.8 837.4 839.6 878.9 888.8 890.1 892.8 893.4 853.6 877.2 882.3 882.5 883.4 662.7 662.7 664.1 665.9 666.5 15065.8 15066.0 15076.2 15105.8 15108.5 14563.6 14788.3 14816.0 14885.4 14888.7 11737.2 11929.5 12140.0 12188.6 12298.1 3788.2 3806.9 3824.0 3838.4 3876.1 78617.6 90789.0 121037.0 121085.0 126313.1 11003.7 11082.1 11129.7 11267.9 11486.5 21398.7 21691.9 21729.0 21879.8 22050.4 8172.0 8184.1 8214.6 8218.8 8340.8 4304.0 4386.2 4532.5 4567.3 4573.6 3626.6 3752.1 3759.6 3760.2 3784.0 629.2 687.1 690.5 691.4 713.6 548.3 588.5 660.9 664.4 672.4 8706.8 9676.6 9736.9 9856.8 9911.7 532.6 632.2 656.8 664.9 667.6 4197.4 4682.4 4695.5 4779.5 4808.8 166591.2 167736.0 168594.0 168927.0 173871.0 72152.0 73961.6 143542.0 150620.0 152262.0 103435.5 108686.5 108919.0 113195.0 115191.0 9626.0 9837.0 9872.3 9880.8 9930.7 64114.0 64178.0 65000.3 65905.7 66870.3 93959.6 98781.0 100294.0 102343.5 103450.5 10317.8 12352.8 12659.6 12741.9 12988.0 13945.9 14054.2 14354.6 14428.6 14470.9 12851.2 13634.2 13649.9 14181.0 14193.3 13051.2 13359.7 13564.1 13741.9 13930.8 12739.6 13045.7 13287.5 13887.2 14031.5 10719.7 10978.3 11504.5 11690.9 11871.1 9322.3 11006.1 11474.9 11505.4 11620.4 05:56:55 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:56:55 INFO - PROCESS | 1675 | 05:56:56 INFO - TEST-INFO | 1675: exit 0 05:56:56 INFO - TEST-OK | dromaeo_css | took 1114319ms 05:56:56 INFO - TEST-START | kraken 05:56:56 INFO - operating with platform_type : mac_ 05:56:56 INFO - Initialising browser for kraken test... 05:56:56 INFO - TEST-INFO | started process 1798 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpq4lrPL/profile http://localhost:49272/getInfo.html) 05:56:59 INFO - PROCESS | 1798 | __metrics Screen width/height:1600/1200 05:56:59 INFO - PROCESS | 1798 | colorDepth:24 05:56:59 INFO - PROCESS | 1798 | Browser inner width/height: 1024/689 05:56:59 INFO - PROCESS | 1798 | __metrics 05:56:59 ERROR - PROCESS | 1798 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 05:57:00 INFO - TEST-INFO | 1798: exit 0 05:57:00 INFO - Browser initialized. 05:57:00 INFO - Running cycle 1/1 for kraken test... 05:57:00 INFO - TEST-INFO | started process 1800 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpq4lrPL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:12 INFO - PROCESS | 1800 | RSS: Main: 224944128 05:57:12 INFO - PROCESS | 1800 | 05:57:14 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:15 INFO - PROCESS | 1800 | RSS: Main: 237686784 05:57:15 INFO - PROCESS | 1800 | 05:57:18 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 05:57:19 INFO - PROCESS | 1800 | RSS: Main: 245030912 05:57:19 INFO - PROCESS | 1800 | 05:57:22 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 05:57:23 INFO - PROCESS | 1800 | RSS: Main: 248954880 05:57:23 INFO - PROCESS | 1800 | 05:57:24 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 05:57:25 INFO - PROCESS | 1800 | RSS: Main: 249569280 05:57:25 INFO - PROCESS | 1800 | 05:57:27 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:28 INFO - PROCESS | 1800 | RSS: Main: 249348096 05:57:28 INFO - PROCESS | 1800 | 05:57:30 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:31 INFO - PROCESS | 1800 | RSS: Main: 251305984 05:57:31 INFO - PROCESS | 1800 | 05:57:34 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:35 INFO - PROCESS | 1800 | RSS: Main: 251633664 05:57:35 INFO - PROCESS | 1800 | 05:57:38 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 05:57:39 INFO - PROCESS | 1800 | RSS: Main: 252112896 05:57:39 INFO - PROCESS | 1800 | 05:57:40 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:41 INFO - PROCESS | 1800 | RSS: Main: 251715584 05:57:41 INFO - PROCESS | 1800 | 05:57:43 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:43 INFO - PROCESS | 1800 | RSS: Main: 251633664 05:57:43 INFO - PROCESS | 1800 | 05:57:46 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:46 INFO - PROCESS | 1800 | RSS: Main: 251678720 05:57:46 INFO - PROCESS | 1800 | 05:57:49 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:50 INFO - PROCESS | 1800 | RSS: Main: 251973632 05:57:50 INFO - PROCESS | 1800 | 05:57:53 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:53 INFO - PROCESS | 1800 | RSS: Main: 251994112 05:57:53 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 05:57:55 INFO - PROCESS | 1800 | RSS: Main: 253796352 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | __start_tp_report 05:57:55 INFO - PROCESS | 1800 | _x_x_mozilla_page_load 05:57:55 INFO - PROCESS | 1800 | _x_x_mozilla_page_load_details 05:57:55 INFO - PROCESS | 1800 | |i|pagename|runs| 05:57:55 INFO - PROCESS | 1800 | |0;ai-astar;106;117;117;118;116;116;118;117;116;117 05:57:55 INFO - PROCESS | 1800 | |1;audio-beat-detection;142;109;113;129;137;143;117;147;174;121 05:57:55 INFO - PROCESS | 1800 | |2;audio-dft;196;201;193;195;209;192;195;199;198;198 05:57:55 INFO - PROCESS | 1800 | |3;audio-fft;77;57;59;83;60;59;58;60;84;79 05:57:55 INFO - PROCESS | 1800 | |4;audio-oscillator;83;68;92;72;68;69;88;90;101;86 05:57:55 INFO - PROCESS | 1800 | |5;imaging-gaussian-blur;100;115;90;92;89;87;89;75;139;134 05:57:55 INFO - PROCESS | 1800 | |6;imaging-darkroom;98;138;123;176;133;174;171;98;99;100 05:57:55 INFO - PROCESS | 1800 | |7;imaging-desaturate;89;142;92;93;93;91;90;95;123;151 05:57:55 INFO - PROCESS | 1800 | |8;json-parse-financial;47;48;87;47;51;58;81;88;88;88 05:57:55 INFO - PROCESS | 1800 | |9;json-stringify-tinderbox;66;73;71;79;74;82;58;67;76;102 05:57:55 INFO - PROCESS | 1800 | |10;stanford-crypto-aes;84;83;83;88;85;87;85;98;108;90 05:57:55 INFO - PROCESS | 1800 | |11;stanford-crypto-ccm;145;154;142;138;163;152;133;162;202;157 05:57:55 INFO - PROCESS | 1800 | |12;stanford-crypto-pbkdf2;173;164;165;166;167;168;179;167;164;163 05:57:55 INFO - PROCESS | 1800 | |13;stanford-crypto-sha256-iterative;68;80;86;90;70;63;61;64;60;62 05:57:55 INFO - PROCESS | 1800 | __end_tp_report 05:57:55 INFO - PROCESS | 1800 | __start_cc_report 05:57:55 INFO - PROCESS | 1800 | _x_x_mozilla_cycle_collect,942 05:57:55 INFO - PROCESS | 1800 | __end_cc_report 05:57:55 INFO - PROCESS | 1800 | __startTimestamp1475845075873__endTimestamp 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | ------- Summary: start ------- 05:57:55 INFO - PROCESS | 1800 | Number of tests: 14 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:3.52 (3.0%) stddev-sans-first:0.78 05:57:55 INFO - PROCESS | 1800 | Values: 106.0 117.0 117.0 118.0 116.0 116.0 118.0 117.0 116.0 117.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:139.50 stddev:19.62 (14.1%) stddev-sans-first:20.55 05:57:55 INFO - PROCESS | 1800 | Values: 142.0 109.0 113.0 129.0 137.0 143.0 117.0 147.0 174.0 121.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#2] audio-dft Cycles:10 Average:197.60 Median:198.00 stddev:4.86 (2.5%) stddev-sans-first:5.12 05:57:55 INFO - PROCESS | 1800 | Values: 196.0 201.0 193.0 195.0 209.0 192.0 195.0 199.0 198.0 198.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#3] audio-fft Cycles:10 Average:67.60 Median:68.50 stddev:11.51 (16.8%) stddev-sans-first:11.70 05:57:55 INFO - PROCESS | 1800 | Values: 77.0 57.0 59.0 83.0 60.0 59.0 58.0 60.0 84.0 79.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:84.50 stddev:11.73 (13.9%) stddev-sans-first:12.43 05:57:55 INFO - PROCESS | 1800 | Values: 83.0 68.0 92.0 72.0 68.0 69.0 88.0 90.0 101.0 86.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:88.00 stddev:21.32 (24.2%) stddev-sans-first:22.61 05:57:55 INFO - PROCESS | 1800 | Values: 100.0 115.0 90.0 92.0 89.0 87.0 89.0 75.0 139.0 134.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#6] imaging-darkroom Cycles:10 Average:131.00 Median:175.00 stddev:32.92 (18.8%) stddev-sans-first:32.68 05:57:55 INFO - PROCESS | 1800 | Values: 98.0 138.0 123.0 176.0 133.0 174.0 171.0 98.0 99.0 100.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#7] imaging-desaturate Cycles:10 Average:105.90 Median:91.50 stddev:23.65 (25.8%) stddev-sans-first:24.28 05:57:55 INFO - PROCESS | 1800 | Values: 89.0 142.0 92.0 93.0 93.0 91.0 90.0 95.0 123.0 151.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:84.00 stddev:19.44 (23.1%) stddev-sans-first:19.03 05:57:55 INFO - PROCESS | 1800 | Values: 47.0 48.0 87.0 47.0 51.0 58.0 81.0 88.0 88.0 88.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:73.50 stddev:11.78 (16.0%) stddev-sans-first:12.06 05:57:55 INFO - PROCESS | 1800 | Values: 66.0 73.0 71.0 79.0 74.0 82.0 58.0 67.0 76.0 102.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:86.00 stddev:8.01 (9.3%) stddev-sans-first:8.28 05:57:55 INFO - PROCESS | 1800 | Values: 84.0 83.0 83.0 88.0 85.0 87.0 85.0 98.0 108.0 90.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:155.50 stddev:19.37 (12.5%) stddev-sans-first:20.22 05:57:55 INFO - PROCESS | 1800 | Values: 145.0 154.0 142.0 138.0 163.0 152.0 133.0 162.0 202.0 157.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:167.00 stddev:4.90 (2.9%) stddev-sans-first:4.80 05:57:55 INFO - PROCESS | 1800 | Values: 173.0 164.0 165.0 166.0 167.0 168.0 179.0 167.0 164.0 163.0 05:57:55 INFO - PROCESS | 1800 | 05:57:55 INFO - PROCESS | 1800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.00 stddev:11.00 (15.9%) stddev-sans-first:11.63 05:57:55 INFO - PROCESS | 1800 | Values: 68.0 80.0 86.0 90.0 70.0 63.0 61.0 64.0 60.0 62.0 05:57:55 INFO - PROCESS | 1800 | -------- Summary: end -------- 05:57:55 INFO - PROCESS | 1800 | 05:57:56 INFO - TEST-INFO | 1800: exit 0 05:57:56 INFO - TEST-OK | kraken | took 60171ms 05:57:56 INFO - SUITE-END | took 1174s 05:57:57 INFO - Completed test suite (00:19:34) 05:57:57 INFO - javascript benchmark 05:57:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7321.528810764561, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.756979441645, 3366.6128395234546, 3465.4108801503758, 3472.3228970350774, 3479.8608055677773, 5796.3044434667845, 5868.85327866803, 5882.0, 5885.852853678655, 5901.527877769779, 5830.970845145768, 5877.3241077276125, 5921.407859214087, 5921.970390148043, 5931.584789064767, 5287.47125287471, 5348.384935732402, 5380.488853558905, 5389.541888939445, 5393.164059570753, 5371.086915224421, 5384.623076384654, 5388.110961691316, 5396.0, 5454.863628409302, 5256.92114618281, 5275.182346736262, 5364.383095943977, 5367.812126575571, 5373.785048598071, 4362.432883725111, 5304.549113325372, 5304.840854774363, 5310.097283461821, 5380.381256155514, 5243.501867322599, 5269.815556455544, 5279.973600131974, 5368.812091576776, 5388.299521062237, 4809.350737650442, 4979.850604481835, 5780.797672081457, 5925.081612350093, 5975.910361344583, 4915.852524424273, 5723.198752174699, 6205.534584906105, 6228.159198508189, 6248.937510624926, 6223.533235007392, 6262.937370626281, 6267.341929097471, 6294.118823364733, 6309.432151106423, 5935.643861368331, 5945.554083443759, 5965.045592705146, 5984.042553191469, 6032.034874420159, 6254.155688981929, 6285.151504546828, 6341.746330146742, 6346.048092786026, 6357.745690172342, 6282.748690052438, 6290.402411770874, 6303.3066362700065, 6312.842178945563, 6330.873382532323, 6327.145835312174, 6328.208973878265, 6341.841453963595, 6345.270293916259, 6362.77730279438, 6142.253225532421, 6194.721237544321, 6231.158793562901, 6259.280182778948, 6265.937340626535, 5746.109353050284, 6260.624362538262, 6284.717187726564, 6296.024116261987, 6324.747010119636, 4506.684532082788, 4981.501849815062, 5041.823536176216, 5043.722595257223, 5053.140966035783, 4401.361802538614, 4439.955600444019, 4444.688871779009, 4474.731516109044, 4531.43357080365, 6016.1878146450545, 6054.757809687651, 6058.757649693963, 6089.995150800069, 6099.359567245464, 6268.404501572343, 6309.526785491014, 6314.652694101868, 6325.557210995186, 6330.683465826783, 5865.853353666193, 5932.110183472513, 5937.614055086492, 5975.163477113208, 6045.909311360333, 5445.564354851603, 5471.50756431915, 5490.341159060858, 5532.695701736443, 5533.750981205855, 6487.448566871869, 6537.313582073813, 6558.376954189344, 6561.967190164019, 6570.244421891448, 6294.4964402846745, 6331.746730130743, 6361.427471527585, 6362.840928976812, 6370.140031095742, 6282.340354262919, 6333.461655759312, 6406.807795766134, 6459.709313081016, 6556.573822701509, 6278.215223097113, 6301.6219026858535, 6308.936910630835, 6314.0, 6337.334579869047, 6295.087212354275, 6339.112524246517, 6341.048842673451, 6363.459105976044, 6381.680915954276, 4997.925031124463, 6091.543134264859, 6198.101275315144, 6280.246370435577, 6300.7479700811455, 6178.289496707936, 6245.843853903689, 6252.374762523893, 6272.0, 6319.842003949754, 5174.896502069862, 6200.255969283715, 6204.348543402878, 6219.346968568235, 6266.530010249158, 6108.908366374597, 6153.630782153085, 6219.813405597839, 6241.316980624606, 6286.308506064238, 6105.725242364193, 6111.174991376108, 6114.052321890114, 6163.19878415803, 6182.0], "value": 5785.019709965459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.90124172682, 466.5777471388391, 485.3060124022646, 495.3362494257694, 525.0234563711497, 32080.0, 41939.58060419399, 42000.57999420005, 42319.0, 42377.364339534855, 43707.562924370744, 43787.34318985218, 43858.0, 43950.0, 44176.0, 8921.509316987564, 9203.631854725803, 9872.308938374317, 9875.456849873253, 9912.504374781269, 9738.464384458852, 9809.558569864374, 9850.458224797634, 9875.1112399884, 9890.30767846251, 9838.606455741798, 9894.356866803635, 9902.603895844193, 9908.0, 9939.552720127576, 9807.215422766161, 9852.261080418997, 9858.556364963593, 9882.703518894445, 9886.505674716307, 9756.4633945133, 9790.608375664964, 9791.0, 9828.164606008499, 9873.60505579776, 40675.0, 40756.0, 40758.0, 41000.58999410027, 41079.58920410788, 3186.4583020886275, 3339.0650617827046, 3501.124718820295, 3682.668559829628, 3717.312297225022, 31448.213794655087, 31481.527777083364, 31554.526682099786, 31648.0, 32686.0, 3159.3997140543224, 3216.485362342014, 3241.3679332530164, 3248.902532924016, 3259.429599820022, 444113.0, 445281.0, 446123.0, 447700.99999999674, 447902.0, 33637.82267620622, 60116.39883601108, 60259.79480410367, 60546.0, 60601.696991515644, 34127.48808767871, 34788.652113479046, 35282.470762938574, 35319.64680353215, 35449.82275088608, 14744.41022359115, 14822.332995015251, 14939.626509337353, 14961.40154393812, 14967.700645987237, 12509.812352814715, 12684.556040538722, 12792.744145117045, 12793.0, 12793.808092878615, 7399.334059934632, 7668.271514206142, 7731.420143489261, 7746.457747957702, 7752.186020467882, 3167.904962851118, 3226.935461290761, 3227.564278822376, 3235.3470154473575, 3250.6424293327714, 892.6875593542338, 913.2283220678516, 975.707287813653, 982.4350998176077, 983.1102851919024, 25294.87352563262, 29584.55623165654, 29604.815807367893, 30712.53931191034, 31031.0, 1018.9847152292722, 1025.0825511167463, 1071.5553045486192, 1083.5990683447176, 1101.1191047162238, 15206.771898421532, 15231.695505876027, 15280.930334876452, 15307.234638268043, 15563.610909727347, 698211.0, 700323.0, 700748.0, 702381.0, 702610.0, 56346.43653563412, 56663.0, 56756.43243567594, 57022.7148864253, 57342.7132864333, 1352.4049418255936, 1360.2722543439213, 1384.5707830572555, 1386.202933313349, 1386.9098508596908, 28563.28591785222, 28905.710942890302, 29503.96736114226, 29727.851360743058, 30089.645965932024, 50051.749741251064, 50685.23972140347, 50746.0, 50913.0, 51115.233271501704, 643053.0, 646278.0, 648435.0, 648546.0, 649519.0, 21645.567088658452, 21879.67180492326, 23671.408214794767, 25413.364665883502, 26538.80575374074, 47033.58899233028, 47503.762481187376, 47711.76144119396, 48124.037519250116, 48997.02005959932, 39602.0, 39990.600328988345, 40950.385744213265, 41495.0, 41778.79110604428, 39873.60126398699, 39937.00157496086, 39942.00289985547, 40590.79704601458, 40763.59236407598, 33594.832025839714, 33603.0, 36719.81640091782, 39082.0, 39185.020374490865, 32841.67158328386, 35082.772102976276, 35253.82373088118, 35470.46794298036, 35717.0, 23171.884140579863, 24277.271681849572, 26118.608220876322, 26313.73686263113, 26613.866930665223], "value": 18728.07093615004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.1641478377974, 376.5631867034241, 380.45594799436805, 381.03217826720135, 403.01462923152883, 19637.312694055712, 20322.085506152223, 20631.381058568248, 21046.89476552615, 21187.0, 19969.10139043743, 20223.696644550342, 20359.38921832344, 20438.08028638711, 20631.865247411424, 4820.084184005045, 5172.27588137661, 5790.71046447677, 5969.701514924258, 6057.969710151443, 5886.470217680408, 5978.402159784008, 5984.820455386345, 6000.399960004008, 6007.4593286604195, 5605.383407825136, 5840.707964601774, 5853.707314634273, 5857.85355366115, 5937.22816033915, 5568.972155139199, 5728.3698793132935, 5759.136129580555, 5810.24466819315, 5833.824985250428, 5084.9745751271375, 5088.643794934356, 5110.977804439127, 5118.334616499868, 5131.615128865313, 25278.873605632038, 25291.494170116493, 25392.238232853044, 25452.36369090769, 25567.23298301054, 1991.9302824401077, 2383.475635360218, 2562.7821635161035, 2566.140342985102, 2622.8557429341377, 9707.466089365082, 10257.0, 10447.68656940293, 14836.0, 14881.18153501557, 1524.7941527893704, 1878.3519685708409, 1923.0, 1930.6428310762412, 1949.064449064457, 90715.0, 123428.38285808514, 129706.0, 130492.0, 131066.0, 11413.771724565462, 11561.0, 11770.58802941893, 11929.224600400947, 12026.218295810744, 12121.0, 14400.495982640557, 14500.927495362455, 14517.201553914636, 14544.854551454562, 8320.635585175469, 8616.267617252479, 8652.956735216283, 8725.52009639476, 8796.736097917073, 8559.572021398904, 8668.263197628146, 8686.218240358272, 8789.0, 8813.383063185644, 4418.359337896051, 4476.037651904791, 4505.594496495266, 4512.684112112186, 4568.309725401623, 1929.2668785861283, 1966.3314473079222, 1968.5964377302619, 1976.40707787666, 2014.869033512817, 818.8812622169871, 878.7495563764296, 884.9247813935759, 957.8563215517728, 988.9011098890197, 16487.34050637961, 20261.088251028737, 20278.290259840836, 21038.0, 21200.575988480145, 769.342212408394, 895.583553647557, 939.6288466056006, 941.1482608239554, 988.5946761827616, 8309.875351869727, 9184.448933064037, 11087.889121108847, 11100.0, 11141.053010494199, 562912.0, 566299.0, 567545.0, 589305.0, 607783.0, 130448.0, 130717.69282307246, 134970.0, 138547.0, 138668.0, 831.7837362285849, 942.58997336159, 944.3436811416137, 972.1979367022235, 973.8685277487449, 18195.45413637593, 18553.35063272779, 18819.341323053628, 18911.71632425487, 19042.19099185575, 23596.056157754185, 35611.0, 47841.76079119582, 51112.0, 52955.0, 73130.54499366294, 75419.0, 79138.0, 79285.60357198177, 79596.60201698955, 7878.054633444023, 7980.521168729895, 8059.919400806151, 8181.304589109992, 8258.710945116893, 12076.706642986737, 12729.872701272869, 13079.738405231652, 13146.145500542434, 13227.206367617973, 10927.0, 10954.233203675667, 11062.834057489305, 11328.263662861887, 11386.146039047271, 10042.347247428894, 10305.227107966783, 10662.626808061681, 10989.835152472559, 11011.0, 11102.944485277521, 11317.660470185907, 11599.478023489131, 11625.709357265798, 11641.59254426091, 7958.363330933395, 8000.559969201517, 8255.917440825755, 8353.457025293337, 8432.45189062709, 8812.603432845666, 10825.296355736851, 10951.233413660968, 11112.722181945515, 11224.214304998899], "value": 9478.28715944733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.4740951029098, 1499.2578673556588, 1663.176727519877, 1835.0549467024478, 1848.639515294518, 7941.16617755136, 8204.466709663868, 8491.957540212297, 8955.417897836636, 8975.506347150913, 8500.78748031298, 8758.34312426569, 8787.95606021969, 8866.689665861697, 8878.112188781135, 2410.7348191698943, 2427.4538228898446, 2428.8178386621075, 2430.890609922558, 2435.9878200608973, 2422.0, 2437.195725410619, 2437.792787613055, 2439.634054891763, 2450.571150048743, 2390.689210402645, 2400.7959323457526, 2424.1757802347197, 2425.514897020594, 2438.2685194441683, 2099.6745504446835, 2400.2679182849224, 2409.554232466999, 2420.056178090546, 2422.019082271665, 2394.2817154853647, 2399.808015358767, 2405.110109259585, 2406.338256979327, 2412.3124909400913, 8689.739307820775, 8710.128987101303, 8811.295096392338, 8814.162654547808, 8894.644214231488, 5220.216967454874, 5348.705821179834, 5365.195220716884, 5365.597580181463, 5367.355917289911, 3520.7887526748477, 3666.7249956253386, 3696.815159242027, 3711.9814400928094, 3765.3975363941913, 1080.5623722392443, 1101.5373543111912, 1107.8227483602666, 1120.3501968858043, 1125.7073160978123, 11606.129540284512, 11663.883361166365, 11687.649370518813, 11699.649010529612, 11701.414929253504, 4562.110388474282, 4743.980044290494, 4823.758812059383, 4829.9034019319415, 4879.2925025871045, 9809.607615695435, 9854.802903942025, 9889.159421449114, 9940.701778946643, 9955.651552195639, 5336.306280183551, 5337.092694241988, 5357.383900851374, 5359.330083739533, 5367.731613419392, 4414.293713005904, 4519.638428925744, 4699.177643912301, 4850.078485087822, 5006.949930500648, 3451.5685539307588, 3964.8215830287704, 3970.861019864291, 4031.8387264509092, 4098.0, 1307.1176955554963, 1318.65714914123, 1320.973580528384, 1324.9403776830065, 1326.6550696818704, 776.5534817479971, 860.8450478913855, 894.2130924786146, 906.1708536688856, 912.9863052054225, 4871.318015477836, 5609.4390560943575, 5623.8594035149445, 5729.656220626775, 6000.309964354068, 749.8087987563136, 896.9730908072638, 912.7489940266347, 932.664240873285, 965.4207475514635, 3330.766846320783, 3816.656500914931, 3926.8429262829736, 3959.9802000990385, 4017.4777278953547, 9469.532222505522, 9955.80088398228, 10147.898521014695, 10629.787404252027, 10717.78564428707, 9005.549722513848, 10449.895501044892, 10495.212859035602, 10518.526666300035, 10519.421431821323, 7907.0906845712325, 7925.286724194735, 8175.305099066527, 8187.71343002992, 8236.876446853303, 5768.278965129359, 5845.444682755132, 5871.7651293949475, 6023.30731965812, 6092.268927728701, 9767.511624418608, 9821.459819709984, 9884.25868059884, 9975.052370024836, 10004.499775011074, 9527.714168574954, 9989.150922171697, 10130.544125514516, 10274.589016439259, 10421.583136674448, 8126.83746325082, 8256.711015114442, 8290.46112002718, 8304.87542686848, 8379.162083791573, 8202.712905048294, 8256.628451719567, 8320.37597180226, 8331.6667333306, 8332.875006875023, 7227.7831665050135, 7420.072490938633, 7486.812829679302, 7560.168381478143, 7563.9621801890635, 7251.20236773965, 7253.637318133967, 7298.343149116605, 7359.668814903235, 7463.104427468738, 6783.525153239226, 6938.167419909643, 6941.791746247621, 6984.441244700513, 7038.929610703827, 4816.494268101939, 4861.1006963710415, 4979.0, 4986.376702912136, 5136.589072874086, 4973.9306049199595, 5033.924491132562, 5223.399309079353, 5232.555232805102, 5257.921131183112], "value": 4600.2151269778615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.91493094606165, 280.7150741996873, 311.1877998424113, 314.0562609358876, 314.69946201377684, 5212.504812042859, 5345.7594408251725, 5404.8919021619595, 5465.863353416162, 5493.615446918718, 4447.3773671685985, 5091.898162036757, 5147.922781158286, 5195.636305458619, 5419.458054194589, 3439.518467414564, 4122.711894898338, 4123.587641235882, 4140.089180380327, 4140.834366625331, 3613.5663720353596, 3657.7988210648405, 4124.401961715549, 4152.5432202457705, 4160.583941605831, 3043.5434684797347, 3436.0379093853635, 4094.9590504095027, 4128.669706423479, 4199.916001679964, 3722.758020728644, 3795.7532760370764, 4084.2852500812237, 4106.425100485934, 4121.8969525761795, 3578.7673801202836, 3585.5836944407074, 3585.910352241189, 3589.2900859850647, 3620.475031120499, 4918.2376731606655, 4948.777305021283, 5263.342047255102, 5263.605229607795, 5276.630635855492, 3609.5127157833617, 4689.437267527885, 4715.0, 4715.622750180011, 4727.905441891177, 4738.218193997986, 5655.575831812631, 5722.509269345695, 5747.298769578333, 5956.344802071769, 3774.622537746231, 3904.4728961590104, 3928.7035278358358, 3966.484357033596, 4020.9195816083516, 5470.398256191816, 5503.6147469677135, 6041.154238406627, 6042.637441753509, 6087.239095113111, 3859.3632050711317, 3987.003249187703, 4012.6789856811383, 4027.2750904836826, 4028.2346354193196, 3667.3215455140885, 3668.486411902336, 3973.6026397360033, 4069.3895915612893, 4079.0, 4606.700564463299, 4635.559621835921, 4641.976790116028, 4665.883352916204, 4692.4603670577635, 5222.608304377187, 5723.427657234327, 5735.942640573541, 5800.53595712342, 5824.767009319665, 1017.3692310767372, 1164.5865717670274, 1174.8942595166477, 1245.8318127052912, 1266.0, 844.3709436469869, 844.7507985144397, 899.7570655922864, 906.1753804038425, 906.7803803883766, 4206.810693518738, 4339.82640694375, 4598.356230127785, 5050.823221187241, 5275.287836142148, 4892.3884514435695, 5787.88424231513, 5820.912686309709, 5829.446202610745, 5837.416258374129, 4498.66907714353, 4607.35497030416, 4988.276699878497, 5274.129768588216, 5298.496642818926, 3082.892098776532, 3145.9685403145677, 3148.826814525223, 3177.4121787469394, 3177.7140057394945, 5428.200259818143, 5930.703464826742, 6240.937590624127, 6258.968705156445, 6311.053341998737, 5047.520485553867, 5254.579633629301, 5762.279715035621, 6171.506279497629, 6260.780872669526, 5270.973645131749, 5276.709780962084, 5584.636998595079, 6323.4625056868845, 6360.332165122595, 5776.458358322493, 5824.94175058244, 5996.67018313997, 6056.818295451144, 6092.238470191226, 4853.733044682435, 4929.767558110472, 5750.62620929655, 6028.4272994065495, 6047.395260473917, 5435.918461223006, 6185.226846644169, 6320.873582528416, 6343.777967771106, 6375.855693799068, 3470.670286322795, 3818.4845045918446, 3927.2145570885364, 4033.1933613276874, 4084.407760874716, 5204.765785539736, 5345.599080068932, 5511.8149597836655, 5565.499105080562, 5939.910901336397, 4748.836535048935, 4785.808567657255, 5578.967890940189, 5776.537876969916, 5900.822975310747, 4612.30815377696, 5884.705764711662, 5929.762809487745, 5933.732982015906, 5963.344032156546, 5145.331106956071, 5505.311836020497, 5698.230738850202, 5781.335146458211, 5800.4489573490455, 5359.437259087739, 5394.002109609734, 5498.202760599611, 5772.6536407815665, 5805.680687562224, 5479.53423958952, 5656.943430565641, 5688.459596338506, 5709.773188456422, 5726.627769194989], "value": 4138.000359161773, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.6566399632179, 726.4914559808129, 755.440973679477, 799.1848314718986, 807.6284908941889, 15296.31166597503, 15710.135942523157, 15720.292586833591, 15775.447859324926, 15804.209789510522, 14123.858761412383, 14143.646408839784, 14146.858531414682, 14155.009149359548, 14224.502142425017, 651.5862427358614, 670.0351493848866, 811.059171361221, 821.2198411509061, 840.8444437779, 834.9540775257359, 835.031363618203, 835.8453686068096, 837.4389159263308, 839.630562552475, 878.8813510176109, 888.7555922121436, 890.0921060518267, 892.7857314244567, 893.3835653399166, 853.63293783673, 877.2236570635002, 882.307388699874, 882.5013867165063, 883.4434306387, 662.6521076434863, 662.6752891083382, 664.050407916679, 665.8501837086665, 666.5167753378762, 15065.849341506555, 15066.020708653903, 15076.170810605412, 15105.848941510554, 15108.54674359771, 14563.563093107225, 14788.334524946404, 14816.0, 14885.404583816635, 14888.702225955529, 11737.237079589799, 11929.522819087226, 12139.96810271128, 12188.634340969786, 12298.139130260884, 3788.2234142000825, 3806.885793426202, 3823.9617603823885, 3838.42423636454, 3876.089119057019, 78617.60691196508, 90789.0, 121037.0, 121085.0, 126313.10530342053, 11003.669889903316, 11082.058025067798, 11129.666110016713, 11267.943660281646, 11486.483108260149, 21398.679019814714, 21691.91540423004, 21729.0, 21879.781202187773, 22050.44873878134, 8171.959140204261, 8184.099749027602, 8214.63034163464, 8218.794530136674, 8340.791480213044, 4303.978480107579, 4386.2224057554395, 4532.546745325441, 4567.269236922143, 4573.611243044378, 3626.637336266405, 3752.137008488063, 3759.586445490994, 3760.191558814813, 3784.0, 629.1537881549309, 687.0552989639247, 690.4890381117937, 691.3708525242106, 713.6182142553813, 548.3173449055871, 588.5350573047331, 660.9074729537869, 664.4020381656451, 672.3881268046055, 8706.782330441789, 9676.56455459506, 9736.853947190797, 9856.802863942825, 9911.702648920544, 532.6484520216638, 632.2476253258608, 656.7668477690447, 664.9401553860176, 667.5961043568668, 4197.391378250137, 4682.4381074271305, 4695.483496815347, 4779.522047795263, 4808.831690890802, 166591.167044164, 167736.0, 168594.0, 168927.0, 173871.0, 72152.0, 73961.6301918487, 143542.0, 150620.0, 152262.0, 103435.48282258691, 108686.45656771665, 108918.99999999841, 113195.0, 115191.0, 9625.951870240604, 9836.999715086968, 9872.325121381231, 9880.802383952425, 9930.652427165014, 64114.0, 64178.0, 65000.349996499426, 65905.67047164733, 66870.3312966864, 93959.59060614233, 98781.01218987718, 100294.0, 102343.48828255812, 103450.48274758577, 10317.793644126925, 12352.814707779571, 12659.556915507914, 12741.853233209056, 12987.960963122738, 13945.930270348583, 14054.227017513726, 14354.569362919128, 14428.567142985727, 14470.927645361706, 12851.228926264454, 13634.181949083088, 13649.931750341184, 14181.0, 14193.290335482978, 13051.21692698441, 13359.666008349868, 13564.137849102603, 13741.862581374058, 13930.791038134234, 12739.61781146567, 13045.695430457257, 13287.534936277183, 13887.166769993833, 14031.508897188549, 10719.678409647722, 10978.341299522055, 11504.53981840717, 11690.88309116898, 11871.050315974873, 9322.300827437834, 11006.119510439306, 11474.94262528682, 11505.446764686994, 11620.360880151335], "value": 7879.008911935558, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 117.0, 118.0, 116.0, 116.0, 118.0, 117.0, 116.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 113.0, 129.0, 137.0, 143.0, 117.0, 147.0, 174.0, 121.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 201.0, 193.0, 195.0, 209.0, 192.0, 195.0, 199.0, 198.0, 198.0], "value": 197.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 57.0, 59.0, 83.0, 60.0, 59.0, 58.0, 60.0, 84.0, 79.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 68.0, 92.0, 72.0, 68.0, 69.0, 88.0, 90.0, 101.0, 86.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 115.0, 90.0, 92.0, 89.0, 87.0, 89.0, 75.0, 139.0, 134.0], "value": 101.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 138.0, 123.0, 176.0, 133.0, 174.0, 171.0, 98.0, 99.0, 100.0], "value": 131.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 142.0, 92.0, 93.0, 93.0, 91.0, 90.0, 95.0, 123.0, 151.0], "value": 105.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 87.0, 47.0, 51.0, 58.0, 81.0, 88.0, 88.0, 88.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 71.0, 79.0, 74.0, 82.0, 58.0, 67.0, 76.0, 102.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 88.0, 85.0, 87.0, 85.0, 98.0, 108.0, 90.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 154.0, 142.0, 138.0, 163.0, 152.0, 133.0, 162.0, 202.0, 157.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 164.0, 165.0, 166.0, 167.0, 168.0, 179.0, 167.0, 164.0, 163.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 80.0, 86.0, 90.0, 70.0, 63.0, 61.0, 64.0, 60.0, 62.0], "value": 70.4, "unit": "score"}]}]} 05:57:57 INFO - Return code: 0 05:57:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:57:57 ERROR - # TBPL SUCCESS # 05:57:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:57 INFO - 2016-10-07 05:57:57.198 screenresolution[1811:10703] starting screenresolution argv=screenresolution get 05:57:57 INFO - 2016-10-07 05:57:57.201 screenresolution[1811:10703] Display 0: 1600x1200x32@60 05:57:57 INFO - 2016-10-07 05:57:57.207 screenresolution[1812:10706] starting screenresolution argv=screenresolution list 05:57:57 INFO - Available Modes on Display 0 05:57:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:57 INFO - Intel Iris: 05:57:57 INFO - Chipset Model: Intel Iris 05:57:57 INFO - Type: GPU 05:57:57 INFO - Bus: Built-In 05:57:57 INFO - VRAM (Dynamic, Max): 1536 MB 05:57:57 INFO - Vendor: Intel (0x8086) 05:57:57 INFO - Device ID: 0x0a2e 05:57:57 INFO - Revision ID: 0x0009 05:57:57 INFO - Displays: 05:57:57 INFO - Display: 05:57:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:57 INFO - Display Serial Number: 1600x1200 60 05:57:57 INFO - Main Display: Yes 05:57:57 INFO - Mirror: Off 05:57:57 INFO - Online: Yes 05:57:57 INFO - Rotation: Supported 05:57:57 INFO - Return code: 0 05:57:57 INFO - Running post-action listener: _resource_record_post_action 05:57:57 INFO - [mozharness: 2016-10-07 12:57:57.442372Z] Finished run-tests step (success) 05:57:57 INFO - Running post-run listener: _resource_record_post_run 05:57:57 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38646784; Write bytes: 667344896; Read time: 377; Write time: 1873 05:57:57 INFO - TinderboxPrint: CPU usage
54.1% 05:57:57 INFO - TinderboxPrint: I/O read bytes / time
38,646,784 / 377 05:57:57 INFO - TinderboxPrint: I/O write bytes / time
667,344,896 / 1,873 05:57:57 INFO - TinderboxPrint: CPU idle
2,216.5 (45.9%) 05:57:57 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 05:57:57 INFO - TinderboxPrint: CPU user
1,640.6 (33.9%) 05:57:57 INFO - TinderboxPrint: Swap in / out
401,809,408 / 0 05:57:57 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 364132864; Write bytes: 366130688; Read time: 28977; Write time: 736 05:57:57 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34595840; Write bytes: 299633152; Read time: 346; Write time: 1131 05:57:57 INFO - Running post-run listener: _upload_blobber_files 05:57:57 INFO - Blob upload gear active. 05:57:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:57:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:57:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:59 INFO - (blobuploader) - INFO - Done attempting. 05:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:59 INFO - (blobuploader) - INFO - Done attempting. 05:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:58:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:02 INFO - (blobuploader) - INFO - Done attempting. 05:58:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:02 INFO - Return code: 0 05:58:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5cd1fe70cd4451c8962cb5fb2eba4fb7b54350dd3fdbc24ed3cd1092e7b2311bbcba994e5138492da46a4d14dbe93313cbbb0a9480c4f858f44c885619d36f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ea2c78c330ecbb61288ae2eb7731e6c989d1a172bfab4203fc1733e60fcdb15b39eb00c98855e73cdd0afeb1897a89f8796ed9ed7cc968921445294bbdaab30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47a9f627756fb747897b64c42d6a926ab5b95e30d19553d10b33744cb7068d09ef040680fe0b7166678cb705ac8b5a121e112f38510e8e1f51f4946508892ea9"} 05:58:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:02 INFO - Contents: 05:58:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5cd1fe70cd4451c8962cb5fb2eba4fb7b54350dd3fdbc24ed3cd1092e7b2311bbcba994e5138492da46a4d14dbe93313cbbb0a9480c4f858f44c885619d36f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ea2c78c330ecbb61288ae2eb7731e6c989d1a172bfab4203fc1733e60fcdb15b39eb00c98855e73cdd0afeb1897a89f8796ed9ed7cc968921445294bbdaab30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47a9f627756fb747897b64c42d6a926ab5b95e30d19553d10b33744cb7068d09ef040680fe0b7166678cb705ac8b5a121e112f38510e8e1f51f4946508892ea9"} 05:58:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:02 INFO - Copying logs to upload dir... 05:58:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.391991 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-07 05:58:02.364093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 05:58:02.367799) ========= 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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5cd1fe70cd4451c8962cb5fb2eba4fb7b54350dd3fdbc24ed3cd1092e7b2311bbcba994e5138492da46a4d14dbe93313cbbb0a9480c4f858f44c885619d36f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ea2c78c330ecbb61288ae2eb7731e6c989d1a172bfab4203fc1733e60fcdb15b39eb00c98855e73cdd0afeb1897a89f8796ed9ed7cc968921445294bbdaab30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47a9f627756fb747897b64c42d6a926ab5b95e30d19553d10b33744cb7068d09ef040680fe0b7166678cb705ac8b5a121e112f38510e8e1f51f4946508892ea9"} build_url:https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5cd1fe70cd4451c8962cb5fb2eba4fb7b54350dd3fdbc24ed3cd1092e7b2311bbcba994e5138492da46a4d14dbe93313cbbb0a9480c4f858f44c885619d36f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ea2c78c330ecbb61288ae2eb7731e6c989d1a172bfab4203fc1733e60fcdb15b39eb00c98855e73cdd0afeb1897a89f8796ed9ed7cc968921445294bbdaab30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47a9f627756fb747897b64c42d6a926ab5b95e30d19553d10b33744cb7068d09ef040680fe0b7166678cb705ac8b5a121e112f38510e8e1f51f4946508892ea9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 05:58:02.402219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:58:02.402986) ========= 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.yHeyLDgSDd/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.Buf8gQV4yN/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005064 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:58:02.455816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 05:58:02.456470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 05:58:02.457164) ========= ========= Total master_lag: 0.18 =========