builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0218 starttime: 1477839124.81 results: success (0) buildid: 20161030060921 builduid: 482de84f74c4497f9fd7a0a1bfa19533 revision: 5fe3e61795353c138026e51c53a92447fd265e06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:04.815298) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:04.816330) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:04.817474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:04.862619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:04.862999) ========= 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.0XlreGdPdK/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.hIMxD719yg/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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-30 07:52:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-10-30 07:52:05 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144132 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:05.097125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:05.097478) ========= 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.0XlreGdPdK/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.hIMxD719yg/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.021238 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:05.139945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 07:52:05.140327) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5fe3e61795353c138026e51c53a92447fd265e06 --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 5fe3e61795353c138026e51c53a92447fd265e06 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0XlreGdPdK/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.hIMxD719yg/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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-30 07:52:05,224 truncating revision to first 12 chars 2016-10-30 07:52:05,224 Setting DEBUG logging. 2016-10-30 07:52:05,224 attempt 1/10 2016-10-30 07:52:05,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5fe3e6179535?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 07:52:06,700 unpacking tar archive at: mozilla-aurora-5fe3e6179535/testing/mozharness/ program finished with exit code 0 elapsedTime=1.732809 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 07:52:06.895708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:06.896112) ========= script_repo_revision: 5fe3e61795353c138026e51c53a92447fd265e06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:06.896556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:06.896841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:52:06.915789) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-30 07:52:06.916213) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0XlreGdPdK/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.hIMxD719yg/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:07 INFO - MultiFileLogger online at 20161030 07:52:07 in /builds/slave/test 07:52:07 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 07:52:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:52:07 INFO - {'append_to_log': False, 07:52:07 INFO - 'base_work_dir': '/builds/slave/test', 07:52:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:52:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:52:07 INFO - 'branch': 'Mozilla-Aurora', 07:52:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:07 INFO - 'config_files': ('talos/mac_config.py',), 07:52:07 INFO - 'default_actions': ('clobber', 07:52:07 INFO - 'read-buildbot-config', 07:52:07 INFO - 'download-and-extract', 07:52:07 INFO - 'populate-webroot', 07:52:07 INFO - 'create-virtualenv', 07:52:07 INFO - 'install', 07:52:07 INFO - 'run-tests'), 07:52:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:07 INFO - 'download_minidump_stackwalk': True, 07:52:07 INFO - 'download_symbols': 'ondemand', 07:52:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:07 INFO - 'installer_path': 'installer.exe', 07:52:07 INFO - 'log_level': 'info', 07:52:07 INFO - 'log_name': 'talos', 07:52:07 INFO - 'log_to_console': True, 07:52:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:52:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:52:07 INFO - 'opt_config_files': (), 07:52:07 INFO - 'pip_index': False, 07:52:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:07 INFO - 'cmd': ('bash', 07:52:07 INFO - '-c', 07:52:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:07 INFO - 'enabled': True, 07:52:07 INFO - 'halt_on_failure': False, 07:52:07 INFO - 'name': 'check_screen_resolution'},), 07:52:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:07 INFO - 'cmd': ('bash', 07:52:07 INFO - '-c', 07:52:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:07 INFO - 'enabled': True, 07:52:07 INFO - 'halt_on_failure': False, 07:52:07 INFO - 'name': 'check_screen_resolution'},), 07:52:07 INFO - 'run_cmd_checks_enabled': True, 07:52:07 INFO - 'sps_profile': False, 07:52:07 INFO - 'sps_profile_interval': 0, 07:52:07 INFO - 'suite': 'dromaeojs-e10s', 07:52:07 INFO - 'system_bits': '32', 07:52:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:07 INFO - 'title': 't-yosemite-r7-0218', 07:52:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:07 INFO - 'use_talos_json': True, 07:52:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:52:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:07 INFO - 'work_dir': 'build'} 07:52:07 INFO - [mozharness: 2016-10-30 14:52:07.120600Z] Running clobber step. 07:52:07 INFO - Running pre-action listener: _resource_record_pre_action 07:52:07 INFO - Running main action method: clobber 07:52:07 INFO - rmtree: /builds/slave/test/build 07:52:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:52:08 INFO - Running post-action listener: _resource_record_post_action 07:52:08 INFO - [mozharness: 2016-10-30 14:52:08.644533Z] Finished clobber step (success) 07:52:08 INFO - [mozharness: 2016-10-30 14:52:08.644613Z] Running read-buildbot-config step. 07:52:08 INFO - Running pre-action listener: _resource_record_pre_action 07:52:08 INFO - Running main action method: read_buildbot_config 07:52:08 INFO - Using buildbot properties: 07:52:08 INFO - { 07:52:08 INFO - "project": "", 07:52:08 INFO - "product": "firefox", 07:52:08 INFO - "script_repo_revision": "production", 07:52:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:52:08 INFO - "repository": "", 07:52:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:52:08 INFO - "buildid": "20161030060921", 07:52:08 INFO - "pgo_build": "False", 07:52:08 INFO - "basedir": "/builds/slave/test", 07:52:08 INFO - "buildnumber": 25, 07:52:08 INFO - "slavename": "t-yosemite-r7-0218", 07:52:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:52:08 INFO - "platform": "yosemite_r7", 07:52:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:52:08 INFO - "branch": "mozilla-aurora", 07:52:08 INFO - "repo_path": "releases/mozilla-aurora", 07:52:08 INFO - "revision": "5fe3e61795353c138026e51c53a92447fd265e06", 07:52:08 INFO - "stage_platform": "macosx64", 07:52:08 INFO - "builduid": "482de84f74c4497f9fd7a0a1bfa19533", 07:52:08 INFO - "slavebuilddir": "test" 07:52:08 INFO - } 07:52:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:52:08 INFO - Running post-action listener: _resource_record_post_action 07:52:08 INFO - [mozharness: 2016-10-30 14:52:08.648011Z] Finished read-buildbot-config step (success) 07:52:08 INFO - [mozharness: 2016-10-30 14:52:08.648125Z] Running download-and-extract step. 07:52:08 INFO - Running pre-action listener: _resource_record_pre_action 07:52:08 INFO - Running main action method: download_and_extract 07:52:08 INFO - mkdir: /builds/slave/test/build/tests 07:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:08 INFO - trying https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:52:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/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 07:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/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 07:52:09 INFO - Downloaded 1199 bytes. 07:52:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:52:09 INFO - Using the following test package requirements: 07:52:09 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:52:09 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:52:09 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:52:09 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'jsshell-mac.zip'], 07:52:09 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:52:09 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:52:09 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:52:09 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:52:09 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:52:09 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:52:09 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:52:09 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:52:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:52:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:52:09 INFO - Fetch https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:52:10 INFO - Expected file size: 16421454 07:52:17 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 07:52:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:52:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:52:17 INFO - Fetch https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:52:18 INFO - Expected file size: 16421454 07:52:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:52:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:52:24 INFO - Fetch https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:52:26 INFO - Expected file size: 14414089 07:52: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')]} 07:52:26 INFO - trying https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:52:26 INFO - Downloading https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/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 07:52:30 INFO - Downloaded 115417755 bytes. 07:52:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:52:30 INFO - mkdir: /builds/slave/test/properties 07:52:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:30 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:30 INFO - Contents: 07:52:30 INFO - build_url:https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:52:31 INFO - Running post-action listener: _resource_record_post_action 07:52:31 INFO - Running post-action listener: set_extra_try_arguments 07:52:31 INFO - [mozharness: 2016-10-30 14:52:31.002965Z] Finished download-and-extract step (success) 07:52:31 INFO - [mozharness: 2016-10-30 14:52:31.003086Z] Running populate-webroot step. 07:52:31 INFO - Running pre-action listener: _resource_record_pre_action 07:52:31 INFO - Running main action method: populate_webroot 07:52:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:31 INFO - '--tppagecycles', 07:52:31 INFO - '7'], 07:52:31 INFO - 'tests': ['tsvgm']}}, 07:52:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['damp', 'tps']}, 07:52:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'tests': ['damp', 'tps']}, 07:52:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['dromaeo_dom']}, 07:52:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['basic_compositor_video']}, 07:52:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:52:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['a11yr', 07:52:31 INFO - 'ts_paint', 07:52:31 INFO - 'tpaint', 07:52:31 INFO - 'sessionrestore', 07:52:31 INFO - 'sessionrestore_no_auto_restore', 07:52:31 INFO - 'tabpaint']}, 07:52:31 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:31 INFO - 'ts_paint', 07:52:31 INFO - 'tpaint', 07:52:31 INFO - 'sessionrestore', 07:52:31 INFO - 'sessionrestore_no_auto_restore', 07:52:31 INFO - 'tabpaint']}, 07:52:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:31 INFO - 'ts_paint', 07:52:31 INFO - 'tpaint', 07:52:31 INFO - 'sessionrestore', 07:52:31 INFO - 'sessionrestore_no_auto_restore', 07:52:31 INFO - 'tabpaint']}, 07:52:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:31 INFO - 'ts_paint', 07:52:31 INFO - 'tpaint', 07:52:31 INFO - 'sessionrestore', 07:52:31 INFO - 'sessionrestore_no_auto_restore', 07:52:31 INFO - 'tabpaint']}, 07:52:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['a11yr', 07:52:31 INFO - 'ts_paint', 07:52:31 INFO - 'tpaint', 07:52:31 INFO - 'sessionrestore', 07:52:31 INFO - 'sessionrestore_no_auto_restore', 07:52:31 INFO - 'tabpaint']}, 07:52:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['a11yr', 07:52:31 INFO - 'ts_paint', 07:52:31 INFO - 'tpaint', 07:52:31 INFO - 'sessionrestore', 07:52:31 INFO - 'sessionrestore_no_auto_restore', 07:52:31 INFO - 'tabpaint']}, 07:52:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['tsvgx', 07:52:31 INFO - 'tsvgr_opacity', 07:52:31 INFO - 'tart', 07:52:31 INFO - 'tscrollx', 07:52:31 INFO - 'cart']}, 07:52:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:31 INFO - 'tsvgr_opacity', 07:52:31 INFO - 'tart', 07:52:31 INFO - 'tscrollx', 07:52:31 INFO - 'cart']}, 07:52:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'talos_options': ['--disable-e10s'], 07:52:31 INFO - 'tests': ['tp5o']}, 07:52:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'tests': ['tp5o']}, 07:52:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'talos_options': ['--disable-e10s', 07:52:31 INFO - '--xperf_path', 07:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:31 INFO - 'tests': ['tp5n']}, 07:52:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:31 INFO - 'talos_options': ['--xperf_path', 07:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:31 INFO - 'tests': ['tp5n']}}, 07:52:31 INFO - 'talos.zip': {'path': '', 07:52:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:31 INFO - Running post-action listener: _resource_record_post_action 07:52:31 INFO - [mozharness: 2016-10-30 14:52:31.021863Z] Finished populate-webroot step (success) 07:52:31 INFO - [mozharness: 2016-10-30 14:52:31.021975Z] Running create-virtualenv step. 07:52:31 INFO - Running pre-action listener: _resource_record_pre_action 07:52:31 INFO - Running main action method: create_virtualenv 07:52:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:31 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 07:52:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:31 INFO - Using real prefix '/tools/python27' 07:52:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:31 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:34 INFO - Installing pip.................done. 07:52:34 INFO - Return code: 0 07:52:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52:34 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')]} 07:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:34 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')]} 07:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:34 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:34 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 07:52:34 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 07:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:34 INFO - 'HOME': '/Users/cltbld', 07:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:34 INFO - 'LOGNAME': 'cltbld', 07:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:34 INFO - 'MOZ_NO_REMOTE': '1', 07:52:34 INFO - 'NO_EM_RESTART': '1', 07:52:34 INFO - 'PAGER': '/bin/cat', 07:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:34 INFO - 'PWD': '/builds/slave/test', 07:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:34 INFO - 'SHELL': '/bin/bash', 07:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:34 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:34 INFO - 'USER': 'cltbld', 07:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:34 INFO - 'XPC_FLAGS': '0x0', 07:52:34 INFO - 'XPC_SERVICE_NAME': '0', 07:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:34 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 07:52:34 INFO - Cleaning up... 07:52:34 INFO - Return code: 0 07:52:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:52:34 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')]} 07:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:34 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')]} 07:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:34 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:34 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 07:52:34 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 07:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:34 INFO - 'HOME': '/Users/cltbld', 07:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:34 INFO - 'LOGNAME': 'cltbld', 07:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:34 INFO - 'MOZ_NO_REMOTE': '1', 07:52:34 INFO - 'NO_EM_RESTART': '1', 07:52:34 INFO - 'PAGER': '/bin/cat', 07:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:34 INFO - 'PWD': '/builds/slave/test', 07:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:34 INFO - 'SHELL': '/bin/bash', 07:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:34 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:34 INFO - 'USER': 'cltbld', 07:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:34 INFO - 'XPC_FLAGS': '0x0', 07:52:34 INFO - 'XPC_SERVICE_NAME': '0', 07:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:35 INFO - Downloading/unpacking psutil>=3.1.1 07:52:35 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 07:52:35 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 07:52:35 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 07:52:35 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 07:52:35 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 07:52:35 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 07:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:39 INFO - Installing collected packages: psutil 07:52:39 INFO - Running setup.py install for psutil 07:52:39 INFO - building 'psutil._psutil_osx' extension 07:52:39 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 07:52:39 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 07:52:39 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 07:52:39 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 07:52:39 INFO - building 'psutil._psutil_posix' extension 07:52:39 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 07:52:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:52:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:52:39 INFO - ^ 07:52:39 INFO - 1 warning generated. 07:52:39 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 07:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:39 INFO - Successfully installed psutil 07:52:39 INFO - Cleaning up... 07:52:40 INFO - Return code: 0 07:52:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:40 INFO - 'HOME': '/Users/cltbld', 07:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:40 INFO - 'LOGNAME': 'cltbld', 07:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:40 INFO - 'MOZ_NO_REMOTE': '1', 07:52:40 INFO - 'NO_EM_RESTART': '1', 07:52:40 INFO - 'PAGER': '/bin/cat', 07:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:40 INFO - 'PWD': '/builds/slave/test', 07:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:40 INFO - 'SHELL': '/bin/bash', 07:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:40 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:40 INFO - 'USER': 'cltbld', 07:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:40 INFO - 'XPC_FLAGS': '0x0', 07:52:40 INFO - 'XPC_SERVICE_NAME': '0', 07:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:52:40 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 07:52:40 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 07:52:40 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 07:52:40 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 07:52:40 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 07:52:40 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 07:52:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:52:42 INFO - Installing collected packages: mozsystemmonitor 07:52:42 INFO - Running setup.py install for mozsystemmonitor 07:52:43 INFO - Successfully installed mozsystemmonitor 07:52:43 INFO - Cleaning up... 07:52:43 INFO - Return code: 0 07:52:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:52:43 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')]} 07:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:43 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')]} 07:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:43 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:43 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 07:52:43 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 07:52:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:43 INFO - 'HOME': '/Users/cltbld', 07:52:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:43 INFO - 'LOGNAME': 'cltbld', 07:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:43 INFO - 'MOZ_NO_REMOTE': '1', 07:52:43 INFO - 'NO_EM_RESTART': '1', 07:52:43 INFO - 'PAGER': '/bin/cat', 07:52:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:43 INFO - 'PWD': '/builds/slave/test', 07:52:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:43 INFO - 'SHELL': '/bin/bash', 07:52:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:43 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:43 INFO - 'USER': 'cltbld', 07:52:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:43 INFO - 'XPC_FLAGS': '0x0', 07:52:43 INFO - 'XPC_SERVICE_NAME': '0', 07:52:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:43 INFO - Downloading/unpacking jsonschema==2.5.1 07:52:43 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 07:52:43 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 07:52:43 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 07:52:43 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 07:52:43 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 07:52:43 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 07:52:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:52:45 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 07:52:45 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 07:52:45 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 07:52:45 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 07:52:45 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 07:52:45 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 07:52:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:46 INFO - warning: no files found matching '*.txt' 07:52:46 INFO - no previously-included directories found matching 'build' 07:52:46 INFO - no previously-included directories found matching 'dist' 07:52:46 INFO - no previously-included directories found matching '.git*' 07:52:46 INFO - Installing collected packages: jsonschema, functools32 07:52:46 INFO - Running setup.py install for functools32 07:52:46 INFO - warning: no files found matching '*.txt' 07:52:46 INFO - no previously-included directories found matching 'build' 07:52:46 INFO - no previously-included directories found matching 'dist' 07:52:46 INFO - no previously-included directories found matching '.git*' 07:52:46 INFO - Successfully installed jsonschema functools32 07:52:46 INFO - Cleaning up... 07:52:46 INFO - Return code: 0 07:52:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:46 INFO - 'HOME': '/Users/cltbld', 07:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:46 INFO - 'LOGNAME': 'cltbld', 07:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:46 INFO - 'MOZ_NO_REMOTE': '1', 07:52:46 INFO - 'NO_EM_RESTART': '1', 07:52:46 INFO - 'PAGER': '/bin/cat', 07:52:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:46 INFO - 'PWD': '/builds/slave/test', 07:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:46 INFO - 'SHELL': '/bin/bash', 07:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:46 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:46 INFO - 'USER': 'cltbld', 07:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:46 INFO - 'XPC_FLAGS': '0x0', 07:52:46 INFO - 'XPC_SERVICE_NAME': '0', 07:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:52:47 INFO - Cleaning up... 07:52:47 INFO - Return code: 0 07:52:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:47 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:47 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 07:52:47 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 07:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:47 INFO - 'HOME': '/Users/cltbld', 07:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:47 INFO - 'LOGNAME': 'cltbld', 07:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:47 INFO - 'MOZ_NO_REMOTE': '1', 07:52:47 INFO - 'NO_EM_RESTART': '1', 07:52:47 INFO - 'PAGER': '/bin/cat', 07:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:47 INFO - 'PWD': '/builds/slave/test', 07:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:47 INFO - 'SHELL': '/bin/bash', 07:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:47 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:47 INFO - 'USER': 'cltbld', 07:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:47 INFO - 'XPC_FLAGS': '0x0', 07:52:47 INFO - 'XPC_SERVICE_NAME': '0', 07:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:50 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 07:52:50 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 07:52:50 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 07:52:50 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 07:52:50 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 07:52:50 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 07:52:50 INFO - Downloading docopt-0.6.1.tar.gz 07:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:51 INFO - Running setup.py install for blobuploader 07:52:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:51 INFO - Running setup.py install for requests 07:52:51 INFO - Running setup.py install for docopt 07:52:51 INFO - Successfully installed blobuploader requests docopt 07:52:51 INFO - Cleaning up... 07:52:51 INFO - Return code: 0 07:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:51 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:51 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 07:52:51 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 07:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:51 INFO - 'HOME': '/Users/cltbld', 07:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:51 INFO - 'LOGNAME': 'cltbld', 07:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:51 INFO - 'MOZ_NO_REMOTE': '1', 07:52:51 INFO - 'NO_EM_RESTART': '1', 07:52:51 INFO - 'PAGER': '/bin/cat', 07:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:51 INFO - 'PWD': '/builds/slave/test', 07:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:51 INFO - 'SHELL': '/bin/bash', 07:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:51 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:51 INFO - 'USER': 'cltbld', 07:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:51 INFO - 'XPC_FLAGS': '0x0', 07:52:51 INFO - 'XPC_SERVICE_NAME': '0', 07:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-eYk55n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-wrdQNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-zcWUsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-iR6Qch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-BRT0VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Fu4hxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-5yZHyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-lNiXZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-r_z58h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-KWJBon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-LcbYwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-vuOohg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-IzfNJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-b9gnGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-sZTL4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-b87blj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Pha4r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:53 INFO - Running setup.py install for manifestparser 07:52:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:54 INFO - Running setup.py install for mozcrash 07:52:54 INFO - Running setup.py install for mozdebug 07:52:54 INFO - Running setup.py install for mozdevice 07:52:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:54 INFO - Running setup.py install for mozfile 07:52:54 INFO - Running setup.py install for mozhttpd 07:52:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:54 INFO - Running setup.py install for mozinfo 07:52:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:54 INFO - Running setup.py install for mozInstall 07:52:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Running setup.py install for mozleak 07:52:55 INFO - Running setup.py install for mozlog 07:52:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Running setup.py install for moznetwork 07:52:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Running setup.py install for mozprocess 07:52:55 INFO - Running setup.py install for mozprofile 07:52:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:55 INFO - Running setup.py install for mozrunner 07:52:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:56 INFO - Running setup.py install for mozscreenshot 07:52:56 INFO - Running setup.py install for moztest 07:52:56 INFO - Running setup.py install for mozversion 07:52:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:56 INFO - Cleaning up... 07:52:56 INFO - Return code: 0 07:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:56 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:52:56 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 07:52:56 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 07:52:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:52:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:56 INFO - 'HOME': '/Users/cltbld', 07:52:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:56 INFO - 'LOGNAME': 'cltbld', 07:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:56 INFO - 'MOZ_NO_REMOTE': '1', 07:52:56 INFO - 'NO_EM_RESTART': '1', 07:52:56 INFO - 'PAGER': '/bin/cat', 07:52:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:56 INFO - 'PWD': '/builds/slave/test', 07:52:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:56 INFO - 'SHELL': '/bin/bash', 07:52:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:52:56 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:52:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:56 INFO - 'USER': 'cltbld', 07:52:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:56 INFO - 'XPC_FLAGS': '0x0', 07:52:56 INFO - 'XPC_SERVICE_NAME': '0', 07:52:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Fei86L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:56 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)) 07:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-WwqkqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:56 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)) 07:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-eW3wGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Ucdb1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-gqrFqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-60QFzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-OWkrxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-YO36oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-r733fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-2YdOJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-2R1MkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-UMfLkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:57 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)) 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-mkCM04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:58 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)) 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-l7Ua0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:58 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)) 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-StWb7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:58 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)) 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-jg5Olc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:58 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)) 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-BXPoeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:58 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)) 07:52:58 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)) 07:52:58 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)) 07:52:58 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)) 07:52:58 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)) 07:52:58 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)) 07:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:01 INFO - Downloading blessings-1.6.tar.gz 07:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:01 INFO - Installing collected packages: blessings 07:53:01 INFO - Running setup.py install for blessings 07:53:01 INFO - Successfully installed blessings 07:53:01 INFO - Cleaning up... 07:53:01 INFO - Return code: 0 07:53:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:01 INFO - Reading from file tmpfile_stdout 07:53:01 INFO - Current package versions: 07:53:01 INFO - blessings == 1.6 07:53:01 INFO - blobuploader == 1.2.4 07:53:01 INFO - docopt == 0.6.1 07:53:01 INFO - functools32 == 3.2.3-2 07:53:01 INFO - jsonschema == 2.5.1 07:53:01 INFO - manifestparser == 1.1 07:53:01 INFO - mozInstall == 1.12 07:53:01 INFO - mozcrash == 0.17 07:53:01 INFO - mozdebug == 0.1 07:53:01 INFO - mozdevice == 0.48 07:53:01 INFO - mozfile == 1.2 07:53:01 INFO - mozhttpd == 0.7 07:53:01 INFO - mozinfo == 0.9 07:53:01 INFO - mozleak == 0.1 07:53:01 INFO - mozlog == 3.4 07:53:01 INFO - moznetwork == 0.27 07:53:01 INFO - mozprocess == 0.23 07:53:01 INFO - mozprofile == 0.28 07:53:01 INFO - mozrunner == 6.12 07:53:01 INFO - mozscreenshot == 0.1 07:53:01 INFO - mozsystemmonitor == 0.3 07:53:01 INFO - moztest == 0.7 07:53:01 INFO - mozversion == 1.4 07:53:01 INFO - psutil == 3.1.1 07:53:01 INFO - requests == 1.2.3 07:53:01 INFO - wsgiref == 0.1.2 07:53:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:01 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')]} 07:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 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')]} 07:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:53:01 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 07:53:01 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 07:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:01 INFO - 'HOME': '/Users/cltbld', 07:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:01 INFO - 'LOGNAME': 'cltbld', 07:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:01 INFO - 'MOZ_NO_REMOTE': '1', 07:53:01 INFO - 'NO_EM_RESTART': '1', 07:53:01 INFO - 'PAGER': '/bin/cat', 07:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:01 INFO - 'PWD': '/builds/slave/test', 07:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:01 INFO - 'SHELL': '/bin/bash', 07:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:53:01 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:01 INFO - 'USER': 'cltbld', 07:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:01 INFO - 'XPC_FLAGS': '0x0', 07:53:01 INFO - 'XPC_SERVICE_NAME': '0', 07:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 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)) 07:53:01 INFO - Cleaning up... 07:53:01 INFO - Return code: 0 07:53:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53:01 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')]} 07:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 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')]} 07:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 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 0x10087d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0abd568e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, '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.0XlreGdPdK/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.hIMxD719yg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 07:53:01 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 07:53:01 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 07:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:01 INFO - 'HOME': '/Users/cltbld', 07:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:01 INFO - 'LOGNAME': 'cltbld', 07:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:01 INFO - 'MOZ_NO_REMOTE': '1', 07:53:01 INFO - 'NO_EM_RESTART': '1', 07:53:01 INFO - 'PAGER': '/bin/cat', 07:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:01 INFO - 'PWD': '/builds/slave/test', 07:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:01 INFO - 'SHELL': '/bin/bash', 07:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:53:01 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:01 INFO - 'USER': 'cltbld', 07:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:01 INFO - 'XPC_FLAGS': '0x0', 07:53:01 INFO - 'XPC_SERVICE_NAME': '0', 07:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:53:02 INFO - Cleaning up... 07:53:02 INFO - Return code: 0 07:53:02 INFO - Running post-action listener: _resource_record_post_action 07:53:02 INFO - Running post-action listener: _start_resource_monitoring 07:53:02 INFO - Starting resource monitoring. 07:53:02 INFO - [mozharness: 2016-10-30 14:53:02.225701Z] Finished create-virtualenv step (success) 07:53:02 INFO - [mozharness: 2016-10-30 14:53:02.226661Z] Running install step. 07:53:02 INFO - Running pre-action listener: _resource_record_pre_action 07:53:02 INFO - Running main action method: install 07:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:02 INFO - Reading from file tmpfile_stdout 07:53:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:53:02 INFO - Reading from file tmpfile_stdout 07:53:02 INFO - Output received: 07:53:02 INFO - Usage: mozinstall [options] installer 07:53:02 INFO - Options: 07:53:02 INFO - -h, --help show this help message and exit 07:53:02 INFO - -d DEST, --destination=DEST 07:53:02 INFO - Directory to install application into. [default: 07:53:02 INFO - "/builds/slave/test"] 07:53:02 INFO - --app=APP Application being installed. [default: firefox] 07:53:02 INFO - mkdir: /builds/slave/test/build/application 07:53:02 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'] 07:53:02 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 07:53:34 INFO - Reading from file tmpfile_stdout 07:53:34 INFO - Output received: 07:53:34 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:53:34 INFO - Running post-action listener: _resource_record_post_action 07:53:34 INFO - [mozharness: 2016-10-30 14:53:34.306214Z] Finished install step (success) 07:53:34 INFO - [mozharness: 2016-10-30 14:53:34.306354Z] Running run-tests step. 07:53:34 INFO - Running pre-action listener: _resource_record_pre_action 07:53:34 INFO - Running main action method: run_tests 07:53:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:53:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:53:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:53:34 INFO - 2016-10-30 07:53:34.320 screenresolution[1934:17168] starting screenresolution argv=screenresolution get 07:53:34 INFO - 2016-10-30 07:53:34.323 screenresolution[1934:17168] Display 0: 1600x1200x32@60 07:53:34 INFO - 2016-10-30 07:53:34.329 screenresolution[1935:17170] starting screenresolution argv=screenresolution list 07:53:34 INFO - Available Modes on Display 0 07:53:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:53:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:53:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:53:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:53:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:53:34 INFO - Intel Iris: 07:53:34 INFO - Chipset Model: Intel Iris 07:53:34 INFO - Type: GPU 07:53:34 INFO - Bus: Built-In 07:53:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:53:34 INFO - Vendor: Intel (0x8086) 07:53:34 INFO - Device ID: 0x0a2e 07:53:34 INFO - Revision ID: 0x0009 07:53:34 INFO - Displays: 07:53:34 INFO - Display: 07:53:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:53:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:53:34 INFO - Display Serial Number: 1600x1200 60 07:53:34 INFO - Main Display: Yes 07:53:34 INFO - Mirror: Off 07:53:34 INFO - Online: Yes 07:53:34 INFO - Rotation: Supported 07:53:34 INFO - Return code: 0 07:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:53:34 INFO - Python 2.7.3 07:53:34 INFO - Return code: 0 07:53:34 INFO - grabbing minidump binary from tooltool 07:53:34 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')]} 07:53:34 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 0x100691d30>, '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 0x1004f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100689b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:53:34 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 07:53:34 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 07:53:34 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 07:53:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:34 INFO - Return code: 0 07:53:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:53:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:53:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:53:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:53:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:53:34 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/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 07:53:34 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/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0218 --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 07:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0XlreGdPdK/Render', 07:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:34 INFO - 'HOME': '/Users/cltbld', 07:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:34 INFO - 'LOGNAME': 'cltbld', 07:53:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:53:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:34 INFO - 'MOZ_NO_REMOTE': '1', 07:53:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:53:34 INFO - 'NO_EM_RESTART': '1', 07:53:34 INFO - 'PAGER': '/bin/cat', 07:53:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:34 INFO - 'PWD': '/builds/slave/test', 07:53:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:34 INFO - 'SHELL': '/bin/bash', 07:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hIMxD719yg/Listeners', 07:53:34 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 07:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:34 INFO - 'USER': 'cltbld', 07:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:34 INFO - 'XPC_FLAGS': '0x0', 07:53:34 INFO - 'XPC_SERVICE_NAME': '0', 07:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:34 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/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 07:53:34 INFO - mozversion application_buildid: 20161030060921 07:53:34 INFO - mozversion application_changeset: 5fe3e61795353c138026e51c53a92447fd265e06 07:53:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:53:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:34 INFO - mozversion application_name: Firefox 07:53:34 INFO - mozversion application_remotingname: firefox-dev 07:53:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:34 INFO - mozversion application_vendor: Mozilla 07:53:34 INFO - mozversion application_version: 51.0a2 07:53:34 INFO - mozversion platform_buildid: 20161030060921 07:53:34 INFO - mozversion platform_changeset: 5fe3e61795353c138026e51c53a92447fd265e06 07:53:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:34 INFO - mozversion platform_version: 51.0a2 07:53:34 INFO - using testdate: 1477839214 07:53:34 INFO - actual date: 1477839214 07:53:34 INFO - starting webserver on 'localhost:54521' 07:53:34 INFO - SUITE-START | Running 2 tests 07:53:34 INFO - TEST-START | dromaeo_css 07:53:34 INFO - operating with platform_type : mac_ 07:53:34 INFO - Initialising browser for dromaeo_css test... 07:53:34 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpoxqb_d/profile http://localhost:54521/getInfo.html) 07:53:37 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 07:53:37 INFO - PROCESS | 1945 | colorDepth:24 07:53:37 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 07:53:37 INFO - PROCESS | 1945 | __metrics 07:53:37 ERROR - PROCESS | 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 07:53:38 INFO - TEST-INFO | 1945: exit 0 07:53:38 INFO - Browser initialized. 07:53:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:38 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpoxqb_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:50 INFO - PROCESS | 1948 | RSS: Main: 225783808 07:53:50 INFO - PROCESS | 1948 | 07:54:39 INFO - PROCESS | 1948 | 1477839279818 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] 07:56:51 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54521/tests/dromaeo/cssquery-ext.html) 07:56:53 INFO - PROCESS | 1948 | RSS: Main: 237084672 07:56:53 INFO - PROCESS | 1948 | 07:59:55 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54521/tests/dromaeo/cssquery-ext.html (next: http://localhost:54521/tests/dromaeo/cssquery-jquery.html) 07:59:56 INFO - PROCESS | 1948 | RSS: Main: 247226368 07:59:56 INFO - PROCESS | 1948 | 08:02:57 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54521/tests/dromaeo/cssquery-mootools.html) 08:02:58 INFO - PROCESS | 1948 | RSS: Main: 250638336 08:02:58 INFO - PROCESS | 1948 | 08:06:00 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54521/tests/dromaeo/cssquery-prototype.html) 08:06:00 INFO - PROCESS | 1948 | RSS: Main: 253018112 08:06:00 INFO - PROCESS | 1948 | 08:09:03 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54521/tests/dromaeo/cssquery-yui.html) 08:09:04 INFO - PROCESS | 1948 | RSS: Main: 257384448 08:09:04 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54521/tests/dromaeo/cssquery-yui.html (next: http://localhost:54521/tests/dromaeo/cssquery-dojo.html) 08:12:07 INFO - PROCESS | 1948 | RSS: Main: 258990080 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | __start_tp_report 08:12:07 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 08:12:07 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 08:12:07 INFO - PROCESS | 1948 | |i|pagename|runs| 08:12:07 INFO - PROCESS | 1948 | |0;dojo.html;2806.2984253936515;2836.5036118679227;3388.288459423521;3404.608470025946;3453.1712389026643;5849.707514624273;5859.355470898208;5885.352611212768;5890.617109887859;5927.61470504418;5846.327672317674;5872.207252020976;5895.941040589592;5924.289085309758;5944.464998150165;5353.678779273256;5376.086065368877;5384.434634363374;5409.377921539014;5415.783368665268;5398.304788448186;5404.702741349224;5408.756605952722;5418.864528386783;5448.128299472085;5278.47215278471;5281.762320695559;5390.272313237721;5408.891822163554;5412.269343638617;5308.787648494055;5310.840674779763;5355.277037599952;5366.651167674088;5389.973050134724;5274.736263186864;5324.893502129936;5328.8401347959625;5383.784648614051;5437.075697131497;5654.519365853907;5945.137954996545;5972.552058595623;5974.163617093611;6008.459238668541;5405.8107966221;5410.8917821643345;6071.696415179224;6132.049532322497;6159.692015399257;6204.720787564571;6224;6251.843703907393;6276.184096067482;6285.811425657238;5813.796517121965;6003.969980150115;6011.008183649649;6012.038073908154;6028.728707208143;6215.502759779297;6233.563650544418;6242.313345531988;6263;6338.651374174465;6176.66028368444;6182.072689096672;6192.969035154885;6194.194754681863;6218.19163508741;6138.416850399205;6233.34549872266;6241.970074937584;6248.500119990481;6252.437280644764;6118.7105509427565;6155.507559395238;6158.199434073542;6169.56813023084;6221.129041934133;6095.725692343855;6190.442860142609;6203.286622038433;6203.627782333075;6217.378262173746;4981.825636102719;5020.970701006285;5026.145555255543;5029.874253143701;5045.5459008689395;3515.5781306243416;3996.800159991989;4024.557298697141;4370.606645401929;4482.170798402306;5648.322201335784;6021.849453763691;6031;6035.758569657252;6049.941260279434;6227.532935029891;6246.063090536365;6251.281102673251;6255.56211065221;6258.655773932477;4915.3855768029;5787.276590426197;5884.08796636522;5891.998360278762;5894.027485464936;5431.293931788921;5443.2107344434835;5444.292242008592;5456.727163641802;5484.067708489566;6306.306306306303;6384.776532821329;6390.520710946605;6394.776182833672;6395.136656551306;6105.84735381619;6134.283518479682;6137.8979746733885;6139.553468857771;6223.190985171898;6324.936750632435;6421.165248517849;6425.967870160806;6427.967860160669;6452.967735161482;6190.226221722285;6203.472704820141;6208.596441231305;6210.192674952408;6211.937880621136;6115.240341084353;6154.569180157525;6163.691815409301;6205;6225.875482490234;5215.55667768244;6123.740204357283;6154.230721159855;6225.284092329259;6234.937650623436;6178.474829639531;6180.598261113013;6188.040853667689;6201.81394558164;6208.2860471044605;4994.02616489781;5994.400559943971;6063.242094738158;6097.847553811191;6141.416565426277;6116.396640261158;6118.162361256354;6137.232845894263;6143.815685529441;6231.189945307081;6099.3290738017895;6121.081837724377;6136.355682653257;6162.291336496181;6164.753409863734 08:12:07 INFO - PROCESS | 1948 | |1;ext.html;443.4456928838951;458.49107490685344;460.5808714070197;515.7137788527366;535.2159086937636;41804.58195418049;43751.78124109379;43765;43790.78104609472;44090;43752.56247437525;44395;44880.10239795202;45015.77492112535;45675.54324456755;9860.85208721868;9977.60089596419;10008.699739007841;10026.298159128864;10038.899611003906;9920.355176913477;9948.005199480067;10033.749156271115;10053.849192262085;10055.798884022315;10038.849417258747;10046.246531510129;10053.69838904834;10089.243306751987;10097.646582369618;10033.799324013515;10043.497825108716;10081.143102836268;10081.848772268422;10105.848412273821;9833.409995400227;9881.555330010167;9905.455199963999;9918.008199180096;9941.502924853801;41936.790316048224;42338.788306058275;42636.57363426357;42725.35911961323;42779;3107.425126351632;3215.324781795826;3669.8165091745573;3757.8872633820756;3982.283189025974;24550.877245613658;24971.50056998868;27954.02160924358;28766.712332876614;31201.21996950072;3157.36852629475;3280.311134661724;3301.9339613207603;3306.685864842836;3322.896223164414;538644;542978;545854;546173.2691336558;546481;33968.32063358768;63595.72808543896;63701.362986369546;63958.68020659867;64070.67964660147;35887.282254354766;35890.28219435649;35967.82016089903;36093.45859812105;36146.819265903505;12887.484500620058;15504.224788760517;15529.534113976599;15590.298436570381;15607.531774046796;10998.560057597606;13180.340982950815;13197.604071877859;13269.469221231042;13303.268320242287;7555.697772089165;7783.33841623457;7805.41459390548;7865.134835168127;7873.409494287951;3200.695933886277;3241.7406607471344;3261.249912520086;3261.8695252189646;3299.5710557627835;934.9298802589833;957.8658987741721;961.6922584772806;1027.7893031928436;1075.2419544221304;30646.54030189549;31058;31133.066008019796;31146.221344466117;31641.683583163875;1071.346478648024;1078.2344535379812;1132.2923173016864;1148.6496618531428;1183.5206741269799;14545.27273636314;16028.038317700975;16071.437499687454;16557.08936008507;16737.77061765976;665430;717107;720885;732900.3354983191;744164;59671.701641492386;60358.698206508685;61151;61230.693846530485;61236;1326.1247576599399;1338.2505796753849;1360.3606305036617;1361.795730640392;1366.180291824897;30074.587771597126;31375;31599.84200078985;31857.522137167496;32104.357912841144;53878.461215387346;54109.18836217381;54150;54285;54396.45603544072;624077;640175;651041;652886;655745;26719.866400667874;26914.730852692006;27464.58803117995;27735.861320693268;27808.58287125654;48623.75688121537;48739.756301218265;49335.259971099746;49900;50222;33816;33846.83076584601;35333.469997949534;40365;40920.59079409168;32313;36202.732904348224;40410.39384409295;41108.79445602753;41922.79038604788;26955.326116847235;33587.328253435284;37914.62085379111;38553.80723096366;39354.60645393509;29646.55530167006;33231.667683322856;34000.129992850634;34718.13204669904;36604.81697591495;23406;26643.866780665972;26840.194794156207;26948.056818011275;27314.863425682743 08:12:07 INFO - PROCESS | 1948 | |2;jquery.html;301.89735489933423;379.2964051684126;379.67917110042015;393.22534606824547;407.5455866708619;16795;19930;20699.586008279864;21038.63248888821;21277.04253308601;11793.528258869655;12168.391580420988;12182.93908530456;12190.329531875743;12615.747685046294;5265.921011184845;5560.138178582326;5564.527015203692;5568.1091025435935;5583.190437386576;3941.527016757979;4162.375643653446;5475.72621368932;5592.496675299222;5918.615290006136;6110.541709371792;6227.595206311598;6237.781677641284;6252.906206406908;6262.906056409158;6049.092636104598;6169.10547970544;6189.442950134487;6198.566100372931;6205.81382558524;5277.577793776489;6036;6048.274207095133;6050.122732203849;6068.3021452533085;12862.871371286354;13194.07641465098;13249.940004799593;13544.119632223874;13554.796678049837;2126.5109024924354;2247.2696373678455;2247.4830788918475;2341.1571834139695;2345.0971376020357;9731.513424328827;9970.351927124786;9972.850407243825;10410.479476026245;10459.058684718335;1833.8807977481554;1873.531617095726;1903.1055403960117;1929.5465565592074;1952.80471952805;113072.4346378271;117274.82725172724;122781.38609306986;123109;125160.37419812843;11378.31730096197;11680.299182049104;11828.822567661491;11863.822042669366;11906.880931190577;14749.557513274618;14765.114093154445;14832.25838708082;14872;14877.03299285543;7792.259735325135;7929.44493885434;8563.357748168912;8807.207351338282;8882.06738292483;8731.650733970697;8785.472871627722;8805.955970220237;8941.776455588531;8974.551272436353;3754.7371683982406;4582.908341833145;4603.079384123189;4604.493505714368;4675.345451636774;1912.1777635616818;1968.6908206043108;1971.3888694504749;3724.851005959731;3902.180542086137;835.3859912963967;948.4356807699407;990.9594925328377;992.3698451483216;1042.5360714482135;20577.38267851967;20835.583288334452;20839;21693.457663558536;21700.891495542422;907.7639813648499;944.1691311645708;954.374884450686;955.5126885288553;1015.9992407478628;11168.050715689258;11436.94281528587;11476.4835582399;11506.367149806842;11526.193166478433;586389;623808;631729;636065;642428;131359;134655;137277.6272237285;140841;147407;926.356182453202;940.2478017585904;940.3981451870808;948.6774496671165;1006.4665727164468;19318.227270909007;19378.418647440598;19739.40781776549;20102.095405706485;20124.585049794117;57886;58018.129728054955;58583.414165857794;58950.410495894495;59400.70299648647;80808.59595701983;82584.58707706424;82592.58703706443;84947;87034.69447958413;7377.741779037708;7497.437692173218;7563.357114645317;7637.083549974039;7638.9305497229325;12002.819957700467;12846.229226246454;13097.607071787861;13270.270135142273;13336.933315333361;11130.666080017612;11240.662780116609;11467.770644586895;11655.708607284885;11682;9358.906410935804;11328.376939268419;11418.429078545872;11446.198766086627;11467.942660286646;7892.644830982505;8290.544020078712;11534;11636.767264654829;11871.347075910908;11533.942330288295;12100.455479503267;12226.877731222574;12415.689607759878;12436.129470936947;11578.189526733047;11674.533018679158;11747.941260293645;11814.527418903492;11973.281603103493 08:12:07 INFO - PROCESS | 1948 | |3;mootools.html;1423.5088894331454;1486.7918491411203;1513.7880696702457;1709.1368858726348;1840.788309344425;8193.385496087787;8476.406651534395;8738.34462415319;9297.674581389645;9317.627294908203;8714.215720585145;9047.638094476213;9063;9157.679481218158;9214.078592140782;2372.15788395119;2396.628522579003;2429.4047958250253;2438.2563318187945;2444.816638752092;2033.1359172351765;2113.2814842953394;2129.808317251447;2441.353041444019;2448.4490989527394;2049.3749406431034;2413.78275955164;2435.659007738909;2438.146648672968;2451.9387015324583;1957.7944315846773;1971.8619696621313;2349.0368948731025;2353.658719485665;2361.929142125739;2017.9091940862697;2376.4415362389823;2420.1166574200465;2422.878856057208;2426.46617744096;9035.412698174598;9225.261979041728;9228.769280767967;9230.44617322956;9233.307501937314;5386.3536375634785;5494.2582751328855;5545.112781954868;5550.16747487876;5567.749451274703;2835.7306055924655;3634.7819130851967;3713.814309284525;3751.906202344936;3754.718396120302;1048.3311493101091;1097.8847221041835;1106.6071544601632;1121.556984990924;1128.1482480727082;12170.939145304217;12221.511139554406;12298.262104273683;12299.508019679202;12361;4788.209945359046;4844.8304309349705;4848.781804818792;4876.024795041006;5009.649324547319;8987.730368088967;10399.168066554657;10462.947685261677;10491.842622360671;10528.315659482263;5429.294191755047;5472.91790623141;5525.696086715189;5532.336119665585;5535.8339249821765;4038.63652271297;4510.413646226035;4621.907561848744;4998.975005124951;5030.698158110525;4050.311447053949;4059.6346328830546;4133.194027164674;4185.97907010463;4217.36739489073;1148.6783700563856;1168.6377223060879;1222.1322860768776;1236.9814452783035;1242.1118899986552;631.119588174494;825.0347093900032;863.7279257034014;876.460976499461;883.2977782662798;4733.431988161374;6071.301800292935;6096.878062438726;6206.565540412218;6226.62640241587;931.5435436636135;940.2618944128826;968.0658164870933;978.4862946952907;978.8335982882927;3556.270964452281;4070.3283958147167;4077.2864748668862;4146.875593732193;4189.832406703758;9278.953605232065;10922.071623912056;11238.157138214667;11259.887401126047;11293.774124517464;11156.051735602403;11224.102071834233;11253.381064041392;11294.661160165208;11307.265027773168;8065.9596702016115;8396.202360775716;8458.577071146417;8470.983481982079;8585.656573737106;6147.692615369124;6214.5028397727165;6219.968900155471;6249.9062514063235;6299.716512757029;9977.151942085004;10347.327423717434;10371.222158338003;10421;10475.685729428129;9961.701148965543;10589.470526473491;10606.946965265124;10611.151107911193;10635.20235982289;6333.841653958688;7177.210506844347;7628.580428076509;7750.108737495035;7900.486468379537;8537.40238183346;8698.782530436789;8784.956075219583;8810.427322224035;8812.91187088121;7670.7315243966195;7781.610919453891;7822.921770782219;7851.764447066597;7939;7539.660715267936;7636.50362726421;7641.350485208597;7666.310032097138;7672.194419586086;6258.280297765815;7128.536645118051;7267.345938865527;7280.854382912418;7315.963420182865;5032;5088.542031217208;5105.412877519133;5175.689458632494;5258.631895767259;5026.346574945233;5189;5226.738663066907;5353.759080841293;5400.270963419888 08:12:07 INFO - PROCESS | 1948 | |4;prototype.html;307.448130605563;313.4076595235006;314.20192710515295;319.75698469163444;320.69854336923305;4505.864824055284;4812.975935120319;4937.98771251893;5562.833115006551;5614.382417934029;4534.727916325023;4742.810287588492;5431.587787175333;5442.619016668835;5486.533644640211;3985.322495175827;4078.8164532596106;4124.670026397881;4129.132882094764;4172.937405938914;3874.9612503874882;3999.0402303447254;4144.48193975753;4208.726432781875;4209.537420608947;3986.903601509579;4197.265478541259;4216.536181020086;4220.6412454941365;4231.18059234529;4072.7599820098976;4168.478070767203;4188.958110418917;4200.264953633102;4230;2999.4151140527606;3003.6695963444004;3606.737641825366;3641.5266015417824;3642.1987162824134;5282;5321.920171197435;5331.573474122061;5353.57171426285;5375;4071.8778436646653;4473.239549276631;4597.0576031913715;4838.741927098945;4841.346418233528;5372.059889519319;5711.343195532484;5857.004309267435;5859.941400585983;5877.764889404419;3382.8308584570673;4044.928094055078;4046.3121269384274;4051.5138183417885;4066.654334381581;5409.053415652205;5639.913232104107;5815.389384114649;5987.790427335022;6228.314885362606;3280.6063272407464;3980.1840622672285;4072.1855628874346;4078.8164532596106;4110.163986849065;4161.459010328638;4161.771102589326;4163.458750362433;4176.812043458051;4196.916061678749;4356.869293921188;4830.2996065571;4875.219964805614;4876.195427754452;4878.317035614946;5164.974175129176;5824.213731146326;5833.912491312633;5857.736401861926;5938.287405511366;1222.5573822888898;1251.8935890449231;1274.6749578857332;1280.6158152554383;1387.6955661677991;693.9410150137194;777.0519965641907;791.4380789639421;816.3265306122473;819.209462868323;4251.383549385322;4746.38297021385;5269.657472264291;5571.300753270291;5632.5212356950115;5591.189277554732;5770.942290577124;6064.696765161724;6065.302490213594;6070.939290607037;5335.253064570963;5401.529873071011;5483.835484935458;5495.340559132929;5582;2377.4650703591556;2794.413173233603;3099.395617854542;3162;3169.6354919184587;6232.25212974446;6249.937500625027;6282.654454004982;6290.402411770966;6304.793322337146;5770.336411312753;6222.844428889223;6226.346233645492;6260.686965651699;6293.370662933761;5782.710864456761;6348.809535713844;6350.777722779773;6380.426960901817;6434.903476447764;5850.736716847667;6018.398160183947;6026.668533230714;6098.634081955097;6105.252636313588;5991.3409524953095;5991.910121348271;6060.575759696779;6067.302260240129;6116.920247115824;4901.90196196067;5215.713135777417;5505.587080968863;6347.460465860454;6363.300036996019;3751.174741556853;3995.7202995790017;4018.3570628699267;4023.2355852387955;4025.3961905714377;4852.490488498657;6086.939130608815;6095.542834287357;6149.569530133027;6314.336994615499;5075.9848030394805;5406.945930540644;5628;5779.826605201851;5960.493358064613;4708.858734237979;5722.313322401338;5867.9413205867395;5913.881722365614;5965.1209868891165;5728;5777.6822274775295;5796.768129274782;5799;5834;5244.318238628954;5452.454754524516;5783.103618939072;5826.970865145647;5831.591788574759;4867.440244371943;4886.511348865085;5691.573132015033;5754.19441278213;5772.278465191851 08:12:07 INFO - PROCESS | 1948 | |5;yui.html;650.450369437825;702.3783951203184;714.2500374606665;778.8481246157002;816.9795755106121;15736.449224277152;16166.676666466663;16176.595585110379;16191.676166476678;16198.83801161988;14520.927395363035;14524.05593636413;14543.272836358166;14561.781573276383;14603.926980365084;687.2234375156066;700.4466471487518;843.6625349860044;843.9704610338639;876.5310558851016;865.8181781825792;868.9565521723888;881.1100788203928;885.707716453572;887.8135591525787;793.7777422321759;866.1598249697814;912.8493798523235;912.9087091290884;927.8793756811639;740.8147963009247;883.88067610873;911.8267529169469;916.8303863785188;918.9937018964257;683.7060064172404;686.6498085976189;687.5599616245606;689.3244620272161;691.3777600159846;14250;14901.403943842233;15245.847541524554;15287.388504459808;15298.158601276926;14565.41738330476;14847.183404912725;14903.627409314746;15016;15033.398664053424;11117.833232501518;11312.208145429824;11718.648440546796;11860.406979650983;12358.134930554865;4161.83352665893;4188.727732697365;4220.78896055196;4231;4240.98216428055;119128;120253;123351.38324308411;123525;123552;10663.89336106629;10749.892501075046;10781.730456738644;10847.132229421628;11130.833037504444;20589;20981.160753569686;21005.579888402146;21066.15735370568;21222.46943826417;7799.5320280783335;7804;7830.530168189813;7907.683692652229;7914.525128492309;4313.482382114166;4323.610875021263;4382.386465894777;4422.71252368595;4551.998560316725;3576.9284614307567;3652.579953305351;3674.2467794102145;3711.777293362407;3725.962740372616;668.1781408867121;676.0569006236273;683.41567959394;694.1808665774435;705.4145059600519;553.9002979463735;589.666838236395;640.5964242527178;659.6635715784985;694.0491526608579;9097.63387546612;9717.81068412398;9913.603455861828;9922.305438619373;10154.644587439405;630.8044506203091;632.4940047961612;663.7875879718443;665.7902760630386;680.1226417920826;4780.402449693788;4843.782029808667;4856.514348565115;4864.367632207861;4878.609711223094;90349;110457;113780.29329560063;156388;157087;116031.41984290024;124087.37956310342;124768.37615811863;124865;125396;75730.62134689401;79328;106730;109362;112165;9625.181859542017;10243.43661098617;10303.536340864828;10308.226882983956;10496.632617858339;49516.76208094826;61970;62376.688116560945;64534.031989521136;64755;79422;91930;99921;99985.50007249917;100999.49500252452;13010.804837927628;13176.934115329745;13194.538191163263;13278;13366.532171373956;14193.858061419254;14333.498327558485;14683.339249733574;14884.776728348867;15727.606809829387;11218.382988935688;12102.092343074128;12515.812262816247;14486.927565362106;14658.267086645837;10464.63373781914;11197.72005699864;13631.727365452438;14055.789163162357;14182.219977901315;13418.261995590336;13644.65888352799;13780.310984450938;14048.59514048587;14385.280735962951;9766.951165244129;11011.28426652265;11626.244294120856;11831.881681183422;12015.579454719043;9525.952370238105;11565.595204167814;11593.478293476983;11782.705432364259;11832.52669893229 08:12:07 INFO - PROCESS | 1948 | __end_tp_report 08:12:07 INFO - PROCESS | 1948 | __start_cc_report 08:12:07 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,363 08:12:07 INFO - PROCESS | 1948 | __end_cc_report 08:12:07 INFO - PROCESS | 1948 | __startTimestamp1477840327272__endTimestamp 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | ------- Summary: start ------- 08:12:07 INFO - PROCESS | 1948 | Number of tests: 6 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | [#0] dojo.html Cycles:165 Average:5783.92 Median:6095.73 stddev:681.88 (11.2%) stddev-sans-first:642.72 08:12:07 INFO - PROCESS | 1948 | Values: 2806.3 2836.5 3388.3 3404.6 3453.2 5849.7 5859.4 5885.4 5890.6 5927.6 5846.3 5872.2 5895.9 5924.3 5944.5 5353.7 5376.1 5384.4 5409.4 5415.8 5398.3 5404.7 5408.8 5418.9 5448.1 5278.5 5281.8 5390.3 5408.9 5412.3 5308.8 5310.8 5355.3 5366.7 5390.0 5274.7 5324.9 5328.8 5383.8 5437.1 5654.5 5945.1 5972.6 5974.2 6008.5 5405.8 5410.9 6071.7 6132.0 6159.7 6204.7 6224.0 6251.8 6276.2 6285.8 5813.8 6004.0 6011.0 6012.0 6028.7 6215.5 6233.6 6242.3 6263.0 6338.7 6176.7 6182.1 6193.0 6194.2 6218.2 6138.4 6233.3 6242.0 6248.5 6252.4 6118.7 6155.5 6158.2 6169.6 6221.1 6095.7 6190.4 6203.3 6203.6 6217.4 4981.8 5021.0 5026.1 5029.9 5045.5 3515.6 3996.8 4024.6 4370.6 4482.2 5648.3 6021.8 6031.0 6035.8 6049.9 6227.5 6246.1 6251.3 6255.6 6258.7 4915.4 5787.3 5884.1 5892.0 5894.0 5431.3 5443.2 5444.3 5456.7 5484.1 6306.3 6384.8 6390.5 6394.8 6395.1 6105.8 6134.3 6137.9 6139.6 6223.2 6324.9 6421.2 6426.0 6428.0 6453.0 6190.2 6203.5 6208.6 6210.2 6211.9 6115.2 6154.6 6163.7 6205.0 6225.9 5215.6 6123.7 6154.2 6225.3 6234.9 6178.5 6180.6 6188.0 6201.8 6208.3 4994.0 5994.4 6063.2 6097.8 6141.4 6116.4 6118.2 6137.2 6143.8 6231.2 6099.3 6121.1 6136.4 6162.3 6164.8 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | [#1] ext.html Cycles:180 Average:74917.79 Median:35610.38 stddev:171546.22 (481.7%) stddev-sans-first:171936.32 08:12:07 INFO - PROCESS | 1948 | Values: 443.4 458.5 460.6 515.7 535.2 41804.6 43751.8 43765.0 43790.8 44090.0 43752.6 44395.0 44880.1 45015.8 45675.5 9860.9 9977.6 10008.7 10026.3 10038.9 9920.4 9948.0 10033.7 10053.8 10055.8 10038.8 10046.2 10053.7 10089.2 10097.6 10033.8 10043.5 10081.1 10081.8 10105.8 9833.4 9881.6 9905.5 9918.0 9941.5 41936.8 42338.8 42636.6 42725.4 42779.0 3107.4 3215.3 3669.8 3757.9 3982.3 24550.9 24971.5 27954.0 28766.7 31201.2 3157.4 3280.3 3301.9 3306.7 3322.9 538644.0 542978.0 545854.0 546173.3 546481.0 33968.3 63595.7 63701.4 63958.7 64070.7 35887.3 35890.3 35967.8 36093.5 36146.8 12887.5 15504.2 15529.5 15590.3 15607.5 10998.6 13180.3 13197.6 13269.5 13303.3 7555.7 7783.3 7805.4 7865.1 7873.4 3200.7 3241.7 3261.2 3261.9 3299.6 934.9 957.9 961.7 1027.8 1075.2 30646.5 31058.0 31133.1 31146.2 31641.7 1071.3 1078.2 1132.3 1148.6 1183.5 14545.3 16028.0 16071.4 16557.1 16737.8 665430.0 717107.0 720885.0 732900.3 744164.0 59671.7 60358.7 61151.0 61230.7 61236.0 1326.1 1338.3 1360.4 1361.8 1366.2 30074.6 31375.0 31599.8 31857.5 32104.4 53878.5 54109.2 54150.0 54285.0 54396.5 624077.0 640175.0 651041.0 652886.0 655745.0 26719.9 26914.7 27464.6 27735.9 27808.6 48623.8 48739.8 49335.3 49900.0 50222.0 33816.0 33846.8 35333.5 40365.0 40920.6 32313.0 36202.7 40410.4 41108.8 41922.8 26955.3 33587.3 37914.6 38553.8 39354.6 29646.6 33231.7 34000.1 34718.1 36604.8 23406.0 26643.9 26840.2 26948.1 27314.9 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | [#2] jquery.html Cycles:180 Average:36022.86 Median:11974.08 stddev:104454.59 (872.3%) stddev-sans-first:104713.17 08:12:07 INFO - PROCESS | 1948 | Values: 301.9 379.3 379.7 393.2 407.5 16795.0 19930.0 20699.6 21038.6 21277.0 11793.5 12168.4 12182.9 12190.3 12615.7 5265.9 5560.1 5564.5 5568.1 5583.2 3941.5 4162.4 5475.7 5592.5 5918.6 6110.5 6227.6 6237.8 6252.9 6262.9 6049.1 6169.1 6189.4 6198.6 6205.8 5277.6 6036.0 6048.3 6050.1 6068.3 12862.9 13194.1 13249.9 13544.1 13554.8 2126.5 2247.3 2247.5 2341.2 2345.1 9731.5 9970.4 9972.9 10410.5 10459.1 1833.9 1873.5 1903.1 1929.5 1952.8 113072.4 117274.8 122781.4 123109.0 125160.4 11378.3 11680.3 11828.8 11863.8 11906.9 14749.6 14765.1 14832.3 14872.0 14877.0 7792.3 7929.4 8563.4 8807.2 8882.1 8731.7 8785.5 8806.0 8941.8 8974.6 3754.7 4582.9 4603.1 4604.5 4675.3 1912.2 1968.7 1971.4 3724.9 3902.2 835.4 948.4 991.0 992.4 1042.5 20577.4 20835.6 20839.0 21693.5 21700.9 907.8 944.2 954.4 955.5 1016.0 11168.1 11436.9 11476.5 11506.4 11526.2 586389.0 623808.0 631729.0 636065.0 642428.0 131359.0 134655.0 137277.6 140841.0 147407.0 926.4 940.2 940.4 948.7 1006.5 19318.2 19378.4 19739.4 20102.1 20124.6 57886.0 58018.1 58583.4 58950.4 59400.7 80808.6 82584.6 82592.6 84947.0 87034.7 7377.7 7497.4 7563.4 7637.1 7638.9 12002.8 12846.2 13097.6 13270.3 13336.9 11130.7 11240.7 11467.8 11655.7 11682.0 9358.9 11328.4 11418.4 11446.2 11467.9 7892.6 8290.5 11534.0 11636.8 11871.3 11533.9 12100.5 12226.9 12415.7 12436.1 11578.2 11674.5 11747.9 11814.5 11973.3 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | [#3] mootools.html Cycles:180 Average:5866.00 Median:5018.00 stddev:3354.42 (66.8%) stddev-sans-first:3347.22 08:12:07 INFO - PROCESS | 1948 | Values: 1423.5 1486.8 1513.8 1709.1 1840.8 8193.4 8476.4 8738.3 9297.7 9317.6 8714.2 9047.6 9063.0 9157.7 9214.1 2372.2 2396.6 2429.4 2438.3 2444.8 2033.1 2113.3 2129.8 2441.4 2448.4 2049.4 2413.8 2435.7 2438.1 2451.9 1957.8 1971.9 2349.0 2353.7 2361.9 2017.9 2376.4 2420.1 2422.9 2426.5 9035.4 9225.3 9228.8 9230.4 9233.3 5386.4 5494.3 5545.1 5550.2 5567.7 2835.7 3634.8 3713.8 3751.9 3754.7 1048.3 1097.9 1106.6 1121.6 1128.1 12170.9 12221.5 12298.3 12299.5 12361.0 4788.2 4844.8 4848.8 4876.0 5009.6 8987.7 10399.2 10462.9 10491.8 10528.3 5429.3 5472.9 5525.7 5532.3 5535.8 4038.6 4510.4 4621.9 4999.0 5030.7 4050.3 4059.6 4133.2 4186.0 4217.4 1148.7 1168.6 1222.1 1237.0 1242.1 631.1 825.0 863.7 876.5 883.3 4733.4 6071.3 6096.9 6206.6 6226.6 931.5 940.3 968.1 978.5 978.8 3556.3 4070.3 4077.3 4146.9 4189.8 9279.0 10922.1 11238.2 11259.9 11293.8 11156.1 11224.1 11253.4 11294.7 11307.3 8066.0 8396.2 8458.6 8471.0 8585.7 6147.7 6214.5 6220.0 6249.9 6299.7 9977.2 10347.3 10371.2 10421.0 10475.7 9961.7 10589.5 10606.9 10611.2 10635.2 6333.8 7177.2 7628.6 7750.1 7900.5 8537.4 8698.8 8785.0 8810.4 8812.9 7670.7 7781.6 7822.9 7851.8 7939.0 7539.7 7636.5 7641.4 7666.3 7672.2 6258.3 7128.5 7267.3 7280.9 7316.0 5032.0 5088.5 5105.4 5175.7 5258.6 5026.3 5189.0 5226.7 5353.8 5400.3 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | [#4] prototype.html Cycles:180 Average:4725.38 Median:5344.41 stddev:1500.87 (28.1%) stddev-sans-first:1467.99 08:12:07 INFO - PROCESS | 1948 | Values: 307.4 313.4 314.2 319.8 320.7 4505.9 4813.0 4938.0 5562.8 5614.4 4534.7 4742.8 5431.6 5442.6 5486.5 3985.3 4078.8 4124.7 4129.1 4172.9 3875.0 3999.0 4144.5 4208.7 4209.5 3986.9 4197.3 4216.5 4220.6 4231.2 4072.8 4168.5 4189.0 4200.3 4230.0 2999.4 3003.7 3606.7 3641.5 3642.2 5282.0 5321.9 5331.6 5353.6 5375.0 4071.9 4473.2 4597.1 4838.7 4841.3 5372.1 5711.3 5857.0 5859.9 5877.8 3382.8 4044.9 4046.3 4051.5 4066.7 5409.1 5639.9 5815.4 5987.8 6228.3 3280.6 3980.2 4072.2 4078.8 4110.2 4161.5 4161.8 4163.5 4176.8 4196.9 4356.9 4830.3 4875.2 4876.2 4878.3 5165.0 5824.2 5833.9 5857.7 5938.3 1222.6 1251.9 1274.7 1280.6 1387.7 693.9 777.1 791.4 816.3 819.2 4251.4 4746.4 5269.7 5571.3 5632.5 5591.2 5770.9 6064.7 6065.3 6070.9 5335.3 5401.5 5483.8 5495.3 5582.0 2377.5 2794.4 3099.4 3162.0 3169.6 6232.3 6249.9 6282.7 6290.4 6304.8 5770.3 6222.8 6226.3 6260.7 6293.4 5782.7 6348.8 6350.8 6380.4 6434.9 5850.7 6018.4 6026.7 6098.6 6105.3 5991.3 5991.9 6060.6 6067.3 6116.9 4901.9 5215.7 5505.6 6347.5 6363.3 3751.2 3995.7 4018.4 4023.2 4025.4 4852.5 6086.9 6095.5 6149.6 6314.3 5076.0 5406.9 5628.0 5779.8 5960.5 4708.9 5722.3 5867.9 5913.9 5965.1 5728.0 5777.7 5796.8 5799.0 5834.0 5244.3 5452.5 5783.1 5827.0 5831.6 4867.4 4886.5 5691.6 5754.2 5772.3 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - PROCESS | 1948 | [#5] yui.html Cycles:180 Average:24114.58 Median:12399.70 stddev:37741.78 (304.4%) stddev-sans-first:37806.54 08:12:07 INFO - PROCESS | 1948 | Values: 650.5 702.4 714.3 778.8 817.0 15736.4 16166.7 16176.6 16191.7 16198.8 14520.9 14524.1 14543.3 14561.8 14603.9 687.2 700.4 843.7 844.0 876.5 865.8 869.0 881.1 885.7 887.8 793.8 866.2 912.8 912.9 927.9 740.8 883.9 911.8 916.8 919.0 683.7 686.6 687.6 689.3 691.4 14250.0 14901.4 15245.8 15287.4 15298.2 14565.4 14847.2 14903.6 15016.0 15033.4 11117.8 11312.2 11718.6 11860.4 12358.1 4161.8 4188.7 4220.8 4231.0 4241.0 119128.0 120253.0 123351.4 123525.0 123552.0 10663.9 10749.9 10781.7 10847.1 11130.8 20589.0 20981.2 21005.6 21066.2 21222.5 7799.5 7804.0 7830.5 7907.7 7914.5 4313.5 4323.6 4382.4 4422.7 4552.0 3576.9 3652.6 3674.2 3711.8 3726.0 668.2 676.1 683.4 694.2 705.4 553.9 589.7 640.6 659.7 694.0 9097.6 9717.8 9913.6 9922.3 10154.6 630.8 632.5 663.8 665.8 680.1 4780.4 4843.8 4856.5 4864.4 4878.6 90349.0 110457.0 113780.3 156388.0 157087.0 116031.4 124087.4 124768.4 124865.0 125396.0 75730.6 79328.0 106730.0 109362.0 112165.0 9625.2 10243.4 10303.5 10308.2 10496.6 49516.8 61970.0 62376.7 64534.0 64755.0 79422.0 91930.0 99921.0 99985.5 100999.5 13010.8 13176.9 13194.5 13278.0 13366.5 14193.9 14333.5 14683.3 14884.8 15727.6 11218.4 12102.1 12515.8 14486.9 14658.3 10464.6 11197.7 13631.7 14055.8 14182.2 13418.3 13644.7 13780.3 14048.6 14385.3 9767.0 11011.3 11626.2 11831.9 12015.6 9526.0 11565.6 11593.5 11782.7 11832.5 08:12:07 INFO - PROCESS | 1948 | -------- Summary: end -------- 08:12:07 INFO - PROCESS | 1948 | 08:12:07 INFO - TEST-INFO | 1948: exit 0 08:12:07 INFO - TEST-OK | dromaeo_css | took 1112964ms 08:12:07 INFO - TEST-START | kraken 08:12:07 INFO - operating with platform_type : mac_ 08:12:07 INFO - Initialising browser for kraken test... 08:12:07 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpUd94P8/profile http://localhost:54521/getInfo.html) 08:12:10 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 08:12:10 INFO - PROCESS | 1953 | colorDepth:24 08:12:10 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 08:12:10 INFO - PROCESS | 1953 | __metrics 08:12:10 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 08:12:11 INFO - TEST-INFO | 1953: exit 0 08:12:11 INFO - Browser initialized. 08:12:11 INFO - Running cycle 1/1 for kraken test... 08:12:11 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpUd94P8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:23 INFO - PROCESS | 1955 | RSS: Main: 225845248 08:12:23 INFO - PROCESS | 1955 | 08:12:26 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54521/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:27 INFO - PROCESS | 1955 | RSS: Main: 238174208 08:12:27 INFO - PROCESS | 1955 | 08:12:29 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54521/tests/kraken/driver.html?testName=audio-dft) 08:12:30 INFO - PROCESS | 1955 | RSS: Main: 245555200 08:12:30 INFO - PROCESS | 1955 | 08:12:33 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54521/tests/kraken/driver.html?testName=audio-fft) 08:12:34 INFO - PROCESS | 1955 | RSS: Main: 249438208 08:12:34 INFO - PROCESS | 1955 | 08:12:36 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54521/tests/kraken/driver.html?testName=audio-oscillator) 08:12:37 INFO - PROCESS | 1955 | RSS: Main: 250585088 08:12:37 INFO - PROCESS | 1955 | 08:12:39 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:39 INFO - PROCESS | 1955 | RSS: Main: 250818560 08:12:39 INFO - PROCESS | 1955 | 08:12:42 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54521/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:43 INFO - PROCESS | 1955 | RSS: Main: 251707392 08:12:43 INFO - PROCESS | 1955 | 08:12:46 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54521/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:47 INFO - PROCESS | 1955 | RSS: Main: 251920384 08:12:47 INFO - PROCESS | 1955 | 08:12:50 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54521/tests/kraken/driver.html?testName=json-parse-financial) 08:12:50 INFO - PROCESS | 1955 | RSS: Main: 251928576 08:12:50 INFO - PROCESS | 1955 | 08:12:52 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:53 INFO - PROCESS | 1955 | RSS: Main: 251666432 08:12:53 INFO - PROCESS | 1955 | 08:12:55 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:55 INFO - PROCESS | 1955 | RSS: Main: 251695104 08:12:55 INFO - PROCESS | 1955 | 08:12:57 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:58 INFO - PROCESS | 1955 | RSS: Main: 251826176 08:12:58 INFO - PROCESS | 1955 | 08:13:01 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:02 INFO - PROCESS | 1955 | RSS: Main: 252178432 08:13:02 INFO - PROCESS | 1955 | 08:13:05 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:05 INFO - PROCESS | 1955 | RSS: Main: 252170240 08:13:05 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54521/tests/kraken/driver.html?testName=ai-astar) 08:13:07 INFO - PROCESS | 1955 | RSS: Main: 253644800 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | __start_tp_report 08:13:07 INFO - PROCESS | 1955 | _x_x_mozilla_page_load 08:13:07 INFO - PROCESS | 1955 | _x_x_mozilla_page_load_details 08:13:07 INFO - PROCESS | 1955 | |i|pagename|runs| 08:13:07 INFO - PROCESS | 1955 | |0;ai-astar;105;117;120;119;124;118;119;115;117;118 08:13:07 INFO - PROCESS | 1955 | |1;audio-beat-detection;140;108;117;179;145;103;131;145;157;111 08:13:07 INFO - PROCESS | 1955 | |2;audio-dft;195;202;198;198;195;247;199;193;230;266 08:13:07 INFO - PROCESS | 1955 | |3;audio-fft;71;56;64;107;52;73;88;82;96;58 08:13:07 INFO - PROCESS | 1955 | |4;audio-oscillator;90;72;114;103;89;69;88;67;68;85 08:13:07 INFO - PROCESS | 1955 | |5;imaging-gaussian-blur;89;110;114;131;115;84;89;85;96;117 08:13:07 INFO - PROCESS | 1955 | |6;imaging-darkroom;99;103;148;124;128;138;147;173;99;98 08:13:07 INFO - PROCESS | 1955 | |7;imaging-desaturate;94;81;150;132;91;104;123;115;148;152 08:13:07 INFO - PROCESS | 1955 | |8;json-parse-financial;54;55;55;58;60;62;59;58;60;60 08:13:07 INFO - PROCESS | 1955 | |9;json-stringify-tinderbox;71;102;106;88;78;78;103;106;78;71 08:13:07 INFO - PROCESS | 1955 | |10;stanford-crypto-aes;81;81;82;85;86;83;86;84;85;81 08:13:07 INFO - PROCESS | 1955 | |11;stanford-crypto-ccm;160;160;139;137;143;165;151;143;169;153 08:13:07 INFO - PROCESS | 1955 | |12;stanford-crypto-pbkdf2;167;229;189;165;167;168;235;210;165;170 08:13:07 INFO - PROCESS | 1955 | |13;stanford-crypto-sha256-iterative;61;91;66;68;68;67;71;92;90;86 08:13:07 INFO - PROCESS | 1955 | __end_tp_report 08:13:07 INFO - PROCESS | 1955 | __start_cc_report 08:13:07 INFO - PROCESS | 1955 | _x_x_mozilla_cycle_collect,948 08:13:07 INFO - PROCESS | 1955 | __end_cc_report 08:13:07 INFO - PROCESS | 1955 | __startTimestamp1477840387826__endTimestamp 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | ------- Summary: start ------- 08:13:07 INFO - PROCESS | 1955 | Number of tests: 14 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#0] ai-astar Cycles:10 Average:117.20 Median:118.50 stddev:4.89 (4.1%) stddev-sans-first:2.51 08:13:07 INFO - PROCESS | 1955 | Values: 105.0 117.0 120.0 119.0 124.0 118.0 119.0 115.0 117.0 118.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:142.50 stddev:24.25 (17.0%) stddev-sans-first:25.61 08:13:07 INFO - PROCESS | 1955 | Values: 140.0 108.0 117.0 179.0 145.0 103.0 131.0 145.0 157.0 111.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#2] audio-dft Cycles:10 Average:212.30 Median:200.50 stddev:25.96 (12.9%) stddev-sans-first:26.77 08:13:07 INFO - PROCESS | 1955 | Values: 195.0 202.0 198.0 198.0 195.0 247.0 199.0 193.0 230.0 266.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#3] audio-fft Cycles:10 Average:74.70 Median:72.00 stddev:18.26 (25.4%) stddev-sans-first:19.32 08:13:07 INFO - PROCESS | 1955 | Values: 71.0 56.0 64.0 107.0 52.0 73.0 88.0 82.0 96.0 58.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:78.50 stddev:15.81 (20.1%) stddev-sans-first:16.65 08:13:07 INFO - PROCESS | 1955 | Values: 90.0 72.0 114.0 103.0 89.0 69.0 88.0 67.0 68.0 85.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#5] imaging-gaussian-blur Cycles:10 Average:103.00 Median:84.50 stddev:16.40 (19.4%) stddev-sans-first:16.59 08:13:07 INFO - PROCESS | 1955 | Values: 89.0 110.0 114.0 131.0 115.0 84.0 89.0 85.0 96.0 117.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#6] imaging-darkroom Cycles:10 Average:125.70 Median:160.50 stddev:25.94 (16.2%) stddev-sans-first:25.65 08:13:07 INFO - PROCESS | 1955 | Values: 99.0 103.0 148.0 124.0 128.0 138.0 147.0 173.0 99.0 98.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#7] imaging-desaturate Cycles:10 Average:119.00 Median:151.00 stddev:26.18 (17.3%) stddev-sans-first:26.16 08:13:07 INFO - PROCESS | 1955 | Values: 94.0 81.0 150.0 132.0 91.0 104.0 123.0 115.0 148.0 152.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:59.50 stddev:2.64 (4.4%) stddev-sans-first:2.35 08:13:07 INFO - PROCESS | 1955 | Values: 54.0 55.0 55.0 58.0 60.0 62.0 59.0 58.0 60.0 60.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#9] json-stringify-tinderbox Cycles:10 Average:88.10 Median:74.50 stddev:14.71 (19.7%) stddev-sans-first:14.24 08:13:07 INFO - PROCESS | 1955 | Values: 71.0 102.0 106.0 88.0 78.0 78.0 103.0 106.0 78.0 71.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.50 stddev:2.07 (2.4%) stddev-sans-first:2.00 08:13:07 INFO - PROCESS | 1955 | Values: 81.0 81.0 82.0 85.0 86.0 83.0 86.0 84.0 85.0 81.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:156.50 stddev:11.27 (7.2%) stddev-sans-first:11.58 08:13:07 INFO - PROCESS | 1955 | Values: 160.0 160.0 139.0 137.0 143.0 165.0 151.0 143.0 169.0 153.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.50 Median:179.50 stddev:27.92 (15.6%) stddev-sans-first:28.71 08:13:07 INFO - PROCESS | 1955 | Values: 167.0 229.0 189.0 165.0 167.0 168.0 235.0 210.0 165.0 170.0 08:13:07 INFO - PROCESS | 1955 | 08:13:07 INFO - PROCESS | 1955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:78.50 stddev:12.18 (15.5%) stddev-sans-first:11.65 08:13:07 INFO - PROCESS | 1955 | Values: 61.0 91.0 66.0 68.0 68.0 67.0 71.0 92.0 90.0 86.0 08:13:07 INFO - PROCESS | 1955 | -------- Summary: end -------- 08:13:07 INFO - PROCESS | 1955 | 08:13:08 INFO - TEST-INFO | 1955: exit 0 08:13:08 INFO - TEST-OK | kraken | took 60747ms 08:13:08 INFO - SUITE-END | took 1173s 08:13:08 INFO - Completed test suite (00:19:34) 08:13:08 INFO - javascript benchmark 08:13:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7387.338873122196, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2806.2984253936515, 2836.5036118679227, 3388.288459423521, 3404.608470025946, 3453.1712389026643, 5849.707514624273, 5859.355470898208, 5885.352611212768, 5890.617109887859, 5927.61470504418, 5846.327672317674, 5872.207252020976, 5895.941040589592, 5924.289085309758, 5944.464998150165, 5353.678779273256, 5376.086065368877, 5384.434634363374, 5409.377921539014, 5415.783368665268, 5398.304788448186, 5404.702741349224, 5408.756605952722, 5418.864528386783, 5448.128299472085, 5278.47215278471, 5281.762320695559, 5390.272313237721, 5408.891822163554, 5412.269343638617, 5308.787648494055, 5310.840674779763, 5355.277037599952, 5366.651167674088, 5389.973050134724, 5274.736263186864, 5324.893502129936, 5328.8401347959625, 5383.784648614051, 5437.075697131497, 5654.519365853907, 5945.137954996545, 5972.552058595623, 5974.163617093611, 6008.459238668541, 5405.8107966221, 5410.8917821643345, 6071.696415179224, 6132.049532322497, 6159.692015399257, 6204.720787564571, 6224.0, 6251.843703907393, 6276.184096067482, 6285.811425657238, 5813.796517121965, 6003.969980150115, 6011.008183649649, 6012.038073908154, 6028.728707208143, 6215.502759779297, 6233.563650544418, 6242.313345531988, 6263.0, 6338.651374174465, 6176.66028368444, 6182.072689096672, 6192.969035154885, 6194.194754681863, 6218.19163508741, 6138.416850399205, 6233.34549872266, 6241.970074937584, 6248.500119990481, 6252.437280644764, 6118.7105509427565, 6155.507559395238, 6158.199434073542, 6169.56813023084, 6221.129041934133, 6095.725692343855, 6190.442860142609, 6203.286622038433, 6203.627782333075, 6217.378262173746, 4981.825636102719, 5020.970701006285, 5026.145555255543, 5029.874253143701, 5045.5459008689395, 3515.5781306243416, 3996.800159991989, 4024.557298697141, 4370.606645401929, 4482.170798402306, 5648.322201335784, 6021.849453763691, 6031.0, 6035.758569657252, 6049.941260279434, 6227.532935029891, 6246.063090536365, 6251.281102673251, 6255.56211065221, 6258.655773932477, 4915.3855768029, 5787.276590426197, 5884.08796636522, 5891.998360278762, 5894.027485464936, 5431.293931788921, 5443.2107344434835, 5444.292242008592, 5456.727163641802, 5484.067708489566, 6306.306306306303, 6384.776532821329, 6390.520710946605, 6394.776182833672, 6395.136656551306, 6105.84735381619, 6134.283518479682, 6137.8979746733885, 6139.553468857771, 6223.190985171898, 6324.936750632435, 6421.165248517849, 6425.967870160806, 6427.967860160669, 6452.967735161482, 6190.226221722285, 6203.472704820141, 6208.596441231305, 6210.192674952408, 6211.937880621136, 6115.240341084353, 6154.569180157525, 6163.691815409301, 6205.0, 6225.875482490234, 5215.55667768244, 6123.740204357283, 6154.230721159855, 6225.284092329259, 6234.937650623436, 6178.474829639531, 6180.598261113013, 6188.040853667689, 6201.81394558164, 6208.2860471044605, 4994.02616489781, 5994.400559943971, 6063.242094738158, 6097.847553811191, 6141.416565426277, 6116.396640261158, 6118.162361256354, 6137.232845894263, 6143.815685529441, 6231.189945307081, 6099.3290738017895, 6121.081837724377, 6136.355682653257, 6162.291336496181, 6164.753409863734], "value": 5736.479231670775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.4456928838951, 458.49107490685344, 460.5808714070197, 515.7137788527366, 535.2159086937636, 41804.58195418049, 43751.78124109379, 43765.0, 43790.78104609472, 44090.0, 43752.56247437525, 44395.0, 44880.10239795202, 45015.77492112535, 45675.54324456755, 9860.85208721868, 9977.60089596419, 10008.699739007841, 10026.298159128864, 10038.899611003906, 9920.355176913477, 9948.005199480067, 10033.749156271115, 10053.849192262085, 10055.798884022315, 10038.849417258747, 10046.246531510129, 10053.69838904834, 10089.243306751987, 10097.646582369618, 10033.799324013515, 10043.497825108716, 10081.143102836268, 10081.848772268422, 10105.848412273821, 9833.409995400227, 9881.555330010167, 9905.455199963999, 9918.008199180096, 9941.502924853801, 41936.790316048224, 42338.788306058275, 42636.57363426357, 42725.35911961323, 42779.0, 3107.425126351632, 3215.324781795826, 3669.8165091745573, 3757.8872633820756, 3982.283189025974, 24550.877245613658, 24971.50056998868, 27954.02160924358, 28766.712332876614, 31201.21996950072, 3157.36852629475, 3280.311134661724, 3301.9339613207603, 3306.685864842836, 3322.896223164414, 538644.0, 542978.0, 545854.0, 546173.2691336558, 546481.0, 33968.32063358768, 63595.72808543896, 63701.362986369546, 63958.68020659867, 64070.67964660147, 35887.282254354766, 35890.28219435649, 35967.82016089903, 36093.45859812105, 36146.819265903505, 12887.484500620058, 15504.224788760517, 15529.534113976599, 15590.298436570381, 15607.531774046796, 10998.560057597606, 13180.340982950815, 13197.604071877859, 13269.469221231042, 13303.268320242287, 7555.697772089165, 7783.33841623457, 7805.41459390548, 7865.134835168127, 7873.409494287951, 3200.695933886277, 3241.7406607471344, 3261.249912520086, 3261.8695252189646, 3299.5710557627835, 934.9298802589833, 957.8658987741721, 961.6922584772806, 1027.7893031928436, 1075.2419544221304, 30646.54030189549, 31058.0, 31133.066008019796, 31146.221344466117, 31641.683583163875, 1071.346478648024, 1078.2344535379812, 1132.2923173016864, 1148.6496618531428, 1183.5206741269799, 14545.27273636314, 16028.038317700975, 16071.437499687454, 16557.08936008507, 16737.77061765976, 665430.0, 717107.0, 720885.0, 732900.3354983191, 744164.0, 59671.701641492386, 60358.698206508685, 61151.0, 61230.693846530485, 61236.0, 1326.1247576599399, 1338.2505796753849, 1360.3606305036617, 1361.795730640392, 1366.180291824897, 30074.587771597126, 31375.0, 31599.84200078985, 31857.522137167496, 32104.357912841144, 53878.461215387346, 54109.18836217381, 54150.0, 54285.0, 54396.45603544072, 624077.0, 640175.0, 651041.0, 652886.0, 655745.0, 26719.866400667874, 26914.730852692006, 27464.58803117995, 27735.861320693268, 27808.58287125654, 48623.75688121537, 48739.756301218265, 49335.259971099746, 49900.0, 50222.0, 33816.0, 33846.83076584601, 35333.469997949534, 40365.0, 40920.59079409168, 32313.0, 36202.732904348224, 40410.39384409295, 41108.79445602753, 41922.79038604788, 26955.326116847235, 33587.328253435284, 37914.62085379111, 38553.80723096366, 39354.60645393509, 29646.55530167006, 33231.667683322856, 34000.129992850634, 34718.13204669904, 36604.81697591495, 23406.0, 26643.866780665972, 26840.194794156207, 26948.056818011275, 27314.863425682743], "value": 19170.33492368773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.89735489933423, 379.2964051684126, 379.67917110042015, 393.22534606824547, 407.5455866708619, 16795.0, 19930.0, 20699.586008279864, 21038.63248888821, 21277.04253308601, 11793.528258869655, 12168.391580420988, 12182.93908530456, 12190.329531875743, 12615.747685046294, 5265.921011184845, 5560.138178582326, 5564.527015203692, 5568.1091025435935, 5583.190437386576, 3941.527016757979, 4162.375643653446, 5475.72621368932, 5592.496675299222, 5918.615290006136, 6110.541709371792, 6227.595206311598, 6237.781677641284, 6252.906206406908, 6262.906056409158, 6049.092636104598, 6169.10547970544, 6189.442950134487, 6198.566100372931, 6205.81382558524, 5277.577793776489, 6036.0, 6048.274207095133, 6050.122732203849, 6068.3021452533085, 12862.871371286354, 13194.07641465098, 13249.940004799593, 13544.119632223874, 13554.796678049837, 2126.5109024924354, 2247.2696373678455, 2247.4830788918475, 2341.1571834139695, 2345.0971376020357, 9731.513424328827, 9970.351927124786, 9972.850407243825, 10410.479476026245, 10459.058684718335, 1833.8807977481554, 1873.531617095726, 1903.1055403960117, 1929.5465565592074, 1952.80471952805, 113072.4346378271, 117274.82725172724, 122781.38609306986, 123109.0, 125160.37419812843, 11378.31730096197, 11680.299182049104, 11828.822567661491, 11863.822042669366, 11906.880931190577, 14749.557513274618, 14765.114093154445, 14832.25838708082, 14872.0, 14877.03299285543, 7792.259735325135, 7929.44493885434, 8563.357748168912, 8807.207351338282, 8882.06738292483, 8731.650733970697, 8785.472871627722, 8805.955970220237, 8941.776455588531, 8974.551272436353, 3754.7371683982406, 4582.908341833145, 4603.079384123189, 4604.493505714368, 4675.345451636774, 1912.1777635616818, 1968.6908206043108, 1971.3888694504749, 3724.851005959731, 3902.180542086137, 835.3859912963967, 948.4356807699407, 990.9594925328377, 992.3698451483216, 1042.5360714482135, 20577.38267851967, 20835.583288334452, 20839.0, 21693.457663558536, 21700.891495542422, 907.7639813648499, 944.1691311645708, 954.374884450686, 955.5126885288553, 1015.9992407478628, 11168.050715689258, 11436.94281528587, 11476.4835582399, 11506.367149806842, 11526.193166478433, 586389.0, 623808.0, 631729.0, 636065.0, 642428.0, 131359.0, 134655.0, 137277.6272237285, 140841.0, 147407.0, 926.356182453202, 940.2478017585904, 940.3981451870808, 948.6774496671165, 1006.4665727164468, 19318.227270909007, 19378.418647440598, 19739.40781776549, 20102.095405706485, 20124.585049794117, 57886.0, 58018.129728054955, 58583.414165857794, 58950.410495894495, 59400.70299648647, 80808.59595701983, 82584.58707706424, 82592.58703706443, 84947.0, 87034.69447958413, 7377.741779037708, 7497.437692173218, 7563.357114645317, 7637.083549974039, 7638.9305497229325, 12002.819957700467, 12846.229226246454, 13097.607071787861, 13270.270135142273, 13336.933315333361, 11130.666080017612, 11240.662780116609, 11467.770644586895, 11655.708607284885, 11682.0, 9358.906410935804, 11328.376939268419, 11418.429078545872, 11446.198766086627, 11467.942660286646, 7892.644830982505, 8290.544020078712, 11534.0, 11636.767264654829, 11871.347075910908, 11533.942330288295, 12100.455479503267, 12226.877731222574, 12415.689607759878, 12436.129470936947, 11578.189526733047, 11674.533018679158, 11747.941260293645, 11814.527418903492, 11973.281603103493], "value": 9552.941859688586, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.5088894331454, 1486.7918491411203, 1513.7880696702457, 1709.1368858726348, 1840.788309344425, 8193.385496087787, 8476.406651534395, 8738.34462415319, 9297.674581389645, 9317.627294908203, 8714.215720585145, 9047.638094476213, 9063.0, 9157.679481218158, 9214.078592140782, 2372.15788395119, 2396.628522579003, 2429.4047958250253, 2438.2563318187945, 2444.816638752092, 2033.1359172351765, 2113.2814842953394, 2129.808317251447, 2441.353041444019, 2448.4490989527394, 2049.3749406431034, 2413.78275955164, 2435.659007738909, 2438.146648672968, 2451.9387015324583, 1957.7944315846773, 1971.8619696621313, 2349.0368948731025, 2353.658719485665, 2361.929142125739, 2017.9091940862697, 2376.4415362389823, 2420.1166574200465, 2422.878856057208, 2426.46617744096, 9035.412698174598, 9225.261979041728, 9228.769280767967, 9230.44617322956, 9233.307501937314, 5386.3536375634785, 5494.2582751328855, 5545.112781954868, 5550.16747487876, 5567.749451274703, 2835.7306055924655, 3634.7819130851967, 3713.814309284525, 3751.906202344936, 3754.718396120302, 1048.3311493101091, 1097.8847221041835, 1106.6071544601632, 1121.556984990924, 1128.1482480727082, 12170.939145304217, 12221.511139554406, 12298.262104273683, 12299.508019679202, 12361.0, 4788.209945359046, 4844.8304309349705, 4848.781804818792, 4876.024795041006, 5009.649324547319, 8987.730368088967, 10399.168066554657, 10462.947685261677, 10491.842622360671, 10528.315659482263, 5429.294191755047, 5472.91790623141, 5525.696086715189, 5532.336119665585, 5535.8339249821765, 4038.63652271297, 4510.413646226035, 4621.907561848744, 4998.975005124951, 5030.698158110525, 4050.311447053949, 4059.6346328830546, 4133.194027164674, 4185.97907010463, 4217.36739489073, 1148.6783700563856, 1168.6377223060879, 1222.1322860768776, 1236.9814452783035, 1242.1118899986552, 631.119588174494, 825.0347093900032, 863.7279257034014, 876.460976499461, 883.2977782662798, 4733.431988161374, 6071.301800292935, 6096.878062438726, 6206.565540412218, 6226.62640241587, 931.5435436636135, 940.2618944128826, 968.0658164870933, 978.4862946952907, 978.8335982882927, 3556.270964452281, 4070.3283958147167, 4077.2864748668862, 4146.875593732193, 4189.832406703758, 9278.953605232065, 10922.071623912056, 11238.157138214667, 11259.887401126047, 11293.774124517464, 11156.051735602403, 11224.102071834233, 11253.381064041392, 11294.661160165208, 11307.265027773168, 8065.9596702016115, 8396.202360775716, 8458.577071146417, 8470.983481982079, 8585.656573737106, 6147.692615369124, 6214.5028397727165, 6219.968900155471, 6249.9062514063235, 6299.716512757029, 9977.151942085004, 10347.327423717434, 10371.222158338003, 10421.0, 10475.685729428129, 9961.701148965543, 10589.470526473491, 10606.946965265124, 10611.151107911193, 10635.20235982289, 6333.841653958688, 7177.210506844347, 7628.580428076509, 7750.108737495035, 7900.486468379537, 8537.40238183346, 8698.782530436789, 8784.956075219583, 8810.427322224035, 8812.91187088121, 7670.7315243966195, 7781.610919453891, 7822.921770782219, 7851.764447066597, 7939.0, 7539.660715267936, 7636.50362726421, 7641.350485208597, 7666.310032097138, 7672.194419586086, 6258.280297765815, 7128.536645118051, 7267.345938865527, 7280.854382912418, 7315.963420182865, 5032.0, 5088.542031217208, 5105.412877519133, 5175.689458632494, 5258.631895767259, 5026.346574945233, 5189.0, 5226.738663066907, 5353.759080841293, 5400.270963419888], "value": 4660.722257597381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.448130605563, 313.4076595235006, 314.20192710515295, 319.75698469163444, 320.69854336923305, 4505.864824055284, 4812.975935120319, 4937.98771251893, 5562.833115006551, 5614.382417934029, 4534.727916325023, 4742.810287588492, 5431.587787175333, 5442.619016668835, 5486.533644640211, 3985.322495175827, 4078.8164532596106, 4124.670026397881, 4129.132882094764, 4172.937405938914, 3874.9612503874882, 3999.0402303447254, 4144.48193975753, 4208.726432781875, 4209.537420608947, 3986.903601509579, 4197.265478541259, 4216.536181020086, 4220.6412454941365, 4231.18059234529, 4072.7599820098976, 4168.478070767203, 4188.958110418917, 4200.264953633102, 4230.0, 2999.4151140527606, 3003.6695963444004, 3606.737641825366, 3641.5266015417824, 3642.1987162824134, 5282.0, 5321.920171197435, 5331.573474122061, 5353.57171426285, 5375.0, 4071.8778436646653, 4473.239549276631, 4597.0576031913715, 4838.741927098945, 4841.346418233528, 5372.059889519319, 5711.343195532484, 5857.004309267435, 5859.941400585983, 5877.764889404419, 3382.8308584570673, 4044.928094055078, 4046.3121269384274, 4051.5138183417885, 4066.654334381581, 5409.053415652205, 5639.913232104107, 5815.389384114649, 5987.790427335022, 6228.314885362606, 3280.6063272407464, 3980.1840622672285, 4072.1855628874346, 4078.8164532596106, 4110.163986849065, 4161.459010328638, 4161.771102589326, 4163.458750362433, 4176.812043458051, 4196.916061678749, 4356.869293921188, 4830.2996065571, 4875.219964805614, 4876.195427754452, 4878.317035614946, 5164.974175129176, 5824.213731146326, 5833.912491312633, 5857.736401861926, 5938.287405511366, 1222.5573822888898, 1251.8935890449231, 1274.6749578857332, 1280.6158152554383, 1387.6955661677991, 693.9410150137194, 777.0519965641907, 791.4380789639421, 816.3265306122473, 819.209462868323, 4251.383549385322, 4746.38297021385, 5269.657472264291, 5571.300753270291, 5632.5212356950115, 5591.189277554732, 5770.942290577124, 6064.696765161724, 6065.302490213594, 6070.939290607037, 5335.253064570963, 5401.529873071011, 5483.835484935458, 5495.340559132929, 5582.0, 2377.4650703591556, 2794.413173233603, 3099.395617854542, 3162.0, 3169.6354919184587, 6232.25212974446, 6249.937500625027, 6282.654454004982, 6290.402411770966, 6304.793322337146, 5770.336411312753, 6222.844428889223, 6226.346233645492, 6260.686965651699, 6293.370662933761, 5782.710864456761, 6348.809535713844, 6350.777722779773, 6380.426960901817, 6434.903476447764, 5850.736716847667, 6018.398160183947, 6026.668533230714, 6098.634081955097, 6105.252636313588, 5991.3409524953095, 5991.910121348271, 6060.575759696779, 6067.302260240129, 6116.920247115824, 4901.90196196067, 5215.713135777417, 5505.587080968863, 6347.460465860454, 6363.300036996019, 3751.174741556853, 3995.7202995790017, 4018.3570628699267, 4023.2355852387955, 4025.3961905714377, 4852.490488498657, 6086.939130608815, 6095.542834287357, 6149.569530133027, 6314.336994615499, 5075.9848030394805, 5406.945930540644, 5628.0, 5779.826605201851, 5960.493358064613, 4708.858734237979, 5722.313322401338, 5867.9413205867395, 5913.881722365614, 5965.1209868891165, 5728.0, 5777.6822274775295, 5796.768129274782, 5799.0, 5834.0, 5244.318238628954, 5452.454754524516, 5783.103618939072, 5826.970865145647, 5831.591788574759, 4867.440244371943, 4886.511348865085, 5691.573132015033, 5754.19441278213, 5772.278465191851], "value": 4230.332757807915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.450369437825, 702.3783951203184, 714.2500374606665, 778.8481246157002, 816.9795755106121, 15736.449224277152, 16166.676666466663, 16176.595585110379, 16191.676166476678, 16198.83801161988, 14520.927395363035, 14524.05593636413, 14543.272836358166, 14561.781573276383, 14603.926980365084, 687.2234375156066, 700.4466471487518, 843.6625349860044, 843.9704610338639, 876.5310558851016, 865.8181781825792, 868.9565521723888, 881.1100788203928, 885.707716453572, 887.8135591525787, 793.7777422321759, 866.1598249697814, 912.8493798523235, 912.9087091290884, 927.8793756811639, 740.8147963009247, 883.88067610873, 911.8267529169469, 916.8303863785188, 918.9937018964257, 683.7060064172404, 686.6498085976189, 687.5599616245606, 689.3244620272161, 691.3777600159846, 14250.0, 14901.403943842233, 15245.847541524554, 15287.388504459808, 15298.158601276926, 14565.41738330476, 14847.183404912725, 14903.627409314746, 15016.0, 15033.398664053424, 11117.833232501518, 11312.208145429824, 11718.648440546796, 11860.406979650983, 12358.134930554865, 4161.83352665893, 4188.727732697365, 4220.78896055196, 4231.0, 4240.98216428055, 119128.0, 120253.0, 123351.38324308411, 123525.0, 123552.0, 10663.89336106629, 10749.892501075046, 10781.730456738644, 10847.132229421628, 11130.833037504444, 20589.0, 20981.160753569686, 21005.579888402146, 21066.15735370568, 21222.46943826417, 7799.5320280783335, 7804.0, 7830.530168189813, 7907.683692652229, 7914.525128492309, 4313.482382114166, 4323.610875021263, 4382.386465894777, 4422.71252368595, 4551.998560316725, 3576.9284614307567, 3652.579953305351, 3674.2467794102145, 3711.777293362407, 3725.962740372616, 668.1781408867121, 676.0569006236273, 683.41567959394, 694.1808665774435, 705.4145059600519, 553.9002979463735, 589.666838236395, 640.5964242527178, 659.6635715784985, 694.0491526608579, 9097.63387546612, 9717.81068412398, 9913.603455861828, 9922.305438619373, 10154.644587439405, 630.8044506203091, 632.4940047961612, 663.7875879718443, 665.7902760630386, 680.1226417920826, 4780.402449693788, 4843.782029808667, 4856.514348565115, 4864.367632207861, 4878.609711223094, 90349.0, 110457.0, 113780.29329560063, 156388.0, 157087.0, 116031.41984290024, 124087.37956310342, 124768.37615811863, 124865.0, 125396.0, 75730.62134689401, 79328.0, 106730.0, 109362.0, 112165.0, 9625.181859542017, 10243.43661098617, 10303.536340864828, 10308.226882983956, 10496.632617858339, 49516.76208094826, 61970.0, 62376.688116560945, 64534.031989521136, 64755.0, 79422.0, 91930.0, 99921.0, 99985.50007249917, 100999.49500252452, 13010.804837927628, 13176.934115329745, 13194.538191163263, 13278.0, 13366.532171373956, 14193.858061419254, 14333.498327558485, 14683.339249733574, 14884.776728348867, 15727.606809829387, 11218.382988935688, 12102.092343074128, 12515.812262816247, 14486.927565362106, 14658.267086645837, 10464.63373781914, 11197.72005699864, 13631.727365452438, 14055.789163162357, 14182.219977901315, 13418.261995590336, 13644.65888352799, 13780.310984450938, 14048.59514048587, 14385.280735962951, 9766.951165244129, 11011.28426652265, 11626.244294120856, 11831.881681183422, 12015.579454719043, 9525.952370238105, 11565.595204167814, 11593.478293476983, 11782.705432364259, 11832.52669893229], "value": 7845.955490018929, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 120.0, 119.0, 124.0, 118.0, 119.0, 115.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 117.0, 179.0, 145.0, 103.0, 131.0, 145.0, 157.0, 111.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 202.0, 198.0, 198.0, 195.0, 247.0, 199.0, 193.0, 230.0, 266.0], "value": 212.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 56.0, 64.0, 107.0, 52.0, 73.0, 88.0, 82.0, 96.0, 58.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 114.0, 103.0, 89.0, 69.0, 88.0, 67.0, 68.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 110.0, 114.0, 131.0, 115.0, 84.0, 89.0, 85.0, 96.0, 117.0], "value": 103.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 103.0, 148.0, 124.0, 128.0, 138.0, 147.0, 173.0, 99.0, 98.0], "value": 125.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 81.0, 150.0, 132.0, 91.0, 104.0, 123.0, 115.0, 148.0, 152.0], "value": 119.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 58.0, 60.0, 62.0, 59.0, 58.0, 60.0, 60.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 102.0, 106.0, 88.0, 78.0, 78.0, 103.0, 106.0, 78.0, 71.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 85.0, 86.0, 83.0, 86.0, 84.0, 85.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 139.0, 137.0, 143.0, 165.0, 151.0, 143.0, 169.0, 153.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 229.0, 189.0, 165.0, 167.0, 168.0, 235.0, 210.0, 165.0, 170.0], "value": 186.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 91.0, 66.0, 68.0, 68.0, 67.0, 71.0, 92.0, 90.0, 86.0], "value": 76.0, "unit": "score"}]}]} 08:13:09 INFO - Return code: 0 08:13:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:13:09 ERROR - # TBPL SUCCESS # 08:13:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:09 INFO - 2016-10-30 08:13:09.112 screenresolution[1960:20074] starting screenresolution argv=screenresolution get 08:13:09 INFO - 2016-10-30 08:13:09.115 screenresolution[1960:20074] Display 0: 1600x1200x32@60 08:13:09 INFO - 2016-10-30 08:13:09.121 screenresolution[1961:20077] starting screenresolution argv=screenresolution list 08:13:09 INFO - Available Modes on Display 0 08:13:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:09 INFO - Intel Iris: 08:13:09 INFO - Chipset Model: Intel Iris 08:13:09 INFO - Type: GPU 08:13:09 INFO - Bus: Built-In 08:13:09 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:09 INFO - Vendor: Intel (0x8086) 08:13:09 INFO - Device ID: 0x0a2e 08:13:09 INFO - Revision ID: 0x0009 08:13:09 INFO - Displays: 08:13:09 INFO - Display: 08:13:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:09 INFO - Display Serial Number: 1600x1200 60 08:13:09 INFO - Main Display: Yes 08:13:09 INFO - Mirror: Off 08:13:09 INFO - Online: Yes 08:13:09 INFO - Rotation: Supported 08:13:09 INFO - Return code: 0 08:13:09 INFO - Running post-action listener: _resource_record_post_action 08:13:09 INFO - [mozharness: 2016-10-30 15:13:09.357413Z] Finished run-tests step (success) 08:13:09 INFO - Running post-run listener: _resource_record_post_run 08:13:09 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 307200; Write bytes: 665702912; Read time: 4; Write time: 1937 08:13:09 INFO - TinderboxPrint: CPU usage
54.3% 08:13:09 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 4 08:13:09 INFO - TinderboxPrint: I/O write bytes / time
665,702,912 / 1,937 08:13:09 INFO - TinderboxPrint: CPU idle
2,205.6 (45.7%) 08:13:09 INFO - TinderboxPrint: CPU system
978.6 (20.3%) 08:13:09 INFO - TinderboxPrint: CPU user
1,641.4 (34.0%) 08:13:09 INFO - TinderboxPrint: Swap in / out
363,290,624 / 0 08:13:09 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 364247552; Write bytes: 366393344; Read time: 27720; Write time: 785 08:13:09 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 249856; Write bytes: 297822720; Read time: 3; Write time: 1142 08:13:09 INFO - Running post-run listener: _upload_blobber_files 08:13:09 INFO - Blob upload gear active. 08:13:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:09 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 08:13:09 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'] 08:13:09 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 08:13:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:11 INFO - (blobuploader) - INFO - Done attempting. 08:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:12 INFO - (blobuploader) - INFO - Done attempting. 08:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:13:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:14 INFO - (blobuploader) - INFO - Done attempting. 08:13:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:14 INFO - Return code: 0 08:13:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9910204243ec9f51cead8105b134f6bd6a9d79a8eb2405eedbf3807974474108189e924ad912a74c1106e118d05a8ad0dede8b51afb8af4c3dceb465c55fd6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5565fc2a217472ca01f7dd1d6e62e105fd167dbbfcbadfe783a2a4742630ff683800a05f1bef6e29bc1bdd54a264059aa3b2a8cfff7d8f6d1cf5f5dcd0f037ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa9c766aa4a4dd4bcbae4fbe3971644393f0fab94297530786611a9dd6075dcb9f4f6eef16671fdd9d83000affebe344e0491abc45d74b967db0212a719deb50"} 08:13:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:14 INFO - Contents: 08:13:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9910204243ec9f51cead8105b134f6bd6a9d79a8eb2405eedbf3807974474108189e924ad912a74c1106e118d05a8ad0dede8b51afb8af4c3dceb465c55fd6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5565fc2a217472ca01f7dd1d6e62e105fd167dbbfcbadfe783a2a4742630ff683800a05f1bef6e29bc1bdd54a264059aa3b2a8cfff7d8f6d1cf5f5dcd0f037ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa9c766aa4a4dd4bcbae4fbe3971644393f0fab94297530786611a9dd6075dcb9f4f6eef16671fdd9d83000affebe344e0491abc45d74b967db0212a719deb50"} 08:13:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:14 INFO - Copying logs to upload dir... 08:13:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.845838 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-30 08:13:14.800290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 08:13:14.803726) ========= 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.0XlreGdPdK/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.hIMxD719yg/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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/a9910204243ec9f51cead8105b134f6bd6a9d79a8eb2405eedbf3807974474108189e924ad912a74c1106e118d05a8ad0dede8b51afb8af4c3dceb465c55fd6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5565fc2a217472ca01f7dd1d6e62e105fd167dbbfcbadfe783a2a4742630ff683800a05f1bef6e29bc1bdd54a264059aa3b2a8cfff7d8f6d1cf5f5dcd0f037ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa9c766aa4a4dd4bcbae4fbe3971644393f0fab94297530786611a9dd6075dcb9f4f6eef16671fdd9d83000affebe344e0491abc45d74b967db0212a719deb50"} build_url:https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/WHeHp8xhTkqT4gwZv3yh9Q/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/a9910204243ec9f51cead8105b134f6bd6a9d79a8eb2405eedbf3807974474108189e924ad912a74c1106e118d05a8ad0dede8b51afb8af4c3dceb465c55fd6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5565fc2a217472ca01f7dd1d6e62e105fd167dbbfcbadfe783a2a4742630ff683800a05f1bef6e29bc1bdd54a264059aa3b2a8cfff7d8f6d1cf5f5dcd0f037ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa9c766aa4a4dd4bcbae4fbe3971644393f0fab94297530786611a9dd6075dcb9f4f6eef16671fdd9d83000affebe344e0491abc45d74b967db0212a719deb50"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 08:13:14.837665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:13:14.838004) ========= 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.0XlreGdPdK/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.hIMxD719yg/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:13:14.887429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 08:13:14.887747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 08:13:14.888077) ========= ========= Total master_lag: 0.24 =========