builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0100 starttime: 1474300770.29 results: success (0) buildid: 20160919065229 builduid: 545acaaf810d4e38b5646a38601b9d03 revision: 5dddbefdf759f09b1411f33fa0920835b919fc81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.287933) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.288427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.288708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.312222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.312519) ========= 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.lYMHBIQp73/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.MzjYEOBKKo/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-09-19 08:59:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-09-19 08:59:30 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172666 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.507811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.508242) ========= 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.lYMHBIQp73/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.MzjYEOBKKo/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.020940 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:30.557202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-19 08:59:30.557572) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5dddbefdf759f09b1411f33fa0920835b919fc81 --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 5dddbefdf759f09b1411f33fa0920835b919fc81 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lYMHBIQp73/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.MzjYEOBKKo/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-09-19 08:59:30,633 truncating revision to first 12 chars 2016-09-19 08:59:30,633 Setting DEBUG logging. 2016-09-19 08:59:30,633 attempt 1/10 2016-09-19 08:59:30,633 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5dddbefdf759?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 08:59:31,830 unpacking tar archive at: mozilla-aurora-5dddbefdf759/testing/mozharness/ program finished with exit code 0 elapsedTime=1.460165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-19 08:59:32.041276) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:32.041875) ========= script_repo_revision: 5dddbefdf759f09b1411f33fa0920835b919fc81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:32.042411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:32.042723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 08:59:32.062354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-19 08:59:32.062722) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lYMHBIQp73/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.MzjYEOBKKo/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:59:32 INFO - MultiFileLogger online at 20160919 08:59:32 in /builds/slave/test 08:59:32 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 08:59:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:32 INFO - {'append_to_log': False, 08:59:32 INFO - 'base_work_dir': '/builds/slave/test', 08:59:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:59:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:32 INFO - 'branch': 'Mozilla-Aurora', 08:59:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:32 INFO - 'config_files': ('talos/mac_config.py',), 08:59:32 INFO - 'default_actions': ('clobber', 08:59:32 INFO - 'read-buildbot-config', 08:59:32 INFO - 'download-and-extract', 08:59:32 INFO - 'populate-webroot', 08:59:32 INFO - 'create-virtualenv', 08:59:32 INFO - 'install', 08:59:32 INFO - 'run-tests'), 08:59:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:32 INFO - 'download_minidump_stackwalk': True, 08:59:32 INFO - 'download_symbols': 'ondemand', 08:59:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:32 INFO - 'installer_path': 'installer.exe', 08:59:32 INFO - 'log_level': 'info', 08:59:32 INFO - 'log_name': 'talos', 08:59:32 INFO - 'log_to_console': True, 08:59:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:59:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:59:32 INFO - 'opt_config_files': (), 08:59:32 INFO - 'pip_index': False, 08:59:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:32 INFO - 'cmd': ('bash', 08:59:32 INFO - '-c', 08:59:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:32 INFO - 'enabled': True, 08:59:32 INFO - 'halt_on_failure': False, 08:59:32 INFO - 'name': 'check_screen_resolution'},), 08:59:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:32 INFO - 'cmd': ('bash', 08:59:32 INFO - '-c', 08:59:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:32 INFO - 'enabled': True, 08:59:32 INFO - 'halt_on_failure': False, 08:59:32 INFO - 'name': 'check_screen_resolution'},), 08:59:32 INFO - 'run_cmd_checks_enabled': True, 08:59:32 INFO - 'sps_profile': False, 08:59:32 INFO - 'sps_profile_interval': 0, 08:59:32 INFO - 'suite': 'dromaeojs-e10s', 08:59:32 INFO - 'system_bits': '32', 08:59:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:32 INFO - 'title': 't-yosemite-r7-0100', 08:59:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:32 INFO - 'use_talos_json': True, 08:59:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:32 INFO - 'work_dir': 'build'} 08:59:32 INFO - [mozharness: 2016-09-19 15:59:32.259415Z] Running clobber step. 08:59:32 INFO - Running pre-action listener: _resource_record_pre_action 08:59:32 INFO - Running main action method: clobber 08:59:32 INFO - rmtree: /builds/slave/test/build 08:59:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:34 INFO - Running post-action listener: _resource_record_post_action 08:59:34 INFO - [mozharness: 2016-09-19 15:59:34.129539Z] Finished clobber step (success) 08:59:34 INFO - [mozharness: 2016-09-19 15:59:34.129731Z] Running read-buildbot-config step. 08:59:34 INFO - Running pre-action listener: _resource_record_pre_action 08:59:34 INFO - Running main action method: read_buildbot_config 08:59:34 INFO - Using buildbot properties: 08:59:34 INFO - { 08:59:34 INFO - "project": "", 08:59:34 INFO - "product": "firefox", 08:59:34 INFO - "script_repo_revision": "production", 08:59:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:59:34 INFO - "repository": "", 08:59:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:59:34 INFO - "buildid": "20160919065229", 08:59:34 INFO - "pgo_build": "False", 08:59:34 INFO - "basedir": "/builds/slave/test", 08:59:34 INFO - "buildnumber": 66, 08:59:34 INFO - "slavename": "t-yosemite-r7-0100", 08:59:34 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:59:34 INFO - "platform": "yosemite_r7", 08:59:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:59:34 INFO - "branch": "mozilla-aurora", 08:59:34 INFO - "repo_path": "releases/mozilla-aurora", 08:59:34 INFO - "revision": "5dddbefdf759f09b1411f33fa0920835b919fc81", 08:59:34 INFO - "stage_platform": "macosx64", 08:59:34 INFO - "builduid": "545acaaf810d4e38b5646a38601b9d03", 08:59:34 INFO - "slavebuilddir": "test" 08:59:34 INFO - } 08:59:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 08:59:34 INFO - Running post-action listener: _resource_record_post_action 08:59:34 INFO - [mozharness: 2016-09-19 15:59:34.135405Z] Finished read-buildbot-config step (success) 08:59:34 INFO - [mozharness: 2016-09-19 15:59:34.135617Z] Running download-and-extract step. 08:59:34 INFO - Running pre-action listener: _resource_record_pre_action 08:59:34 INFO - Running main action method: download_and_extract 08:59:34 INFO - mkdir: /builds/slave/test/build/tests 08:59: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')]} 08:59:34 INFO - trying https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 08:59:34 INFO - Downloading https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/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 08:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/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 08:59:35 INFO - Downloaded 1199 bytes. 08:59:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:59:35 INFO - Using the following test package requirements: 08:59:35 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:59:35 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 08:59:35 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 08:59:35 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'jsshell-mac.zip'], 08:59:35 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 08:59:35 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:59:35 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 08:59:35 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 08:59:35 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 08:59:35 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:59:35 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 08:59:35 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:59:35 INFO - Expected file size: 16426170 08:59:42 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 08:59:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:59:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:59:42 INFO - Fetch https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:59:43 INFO - Expected file size: 16426170 08:59:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 08:59:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:59:50 INFO - Fetch https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 08:59:50 INFO - Expected file size: 14414059 08:59: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')]} 08:59:51 INFO - trying https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:59:51 INFO - Downloading https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 08:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/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 08:59:54 INFO - Downloaded 115239312 bytes. 08:59:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:59:54 INFO - mkdir: /builds/slave/test/properties 08:59:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:54 INFO - Contents: 08:59:54 INFO - build_url:https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:59:54 INFO - Running post-action listener: _resource_record_post_action 08:59:54 INFO - Running post-action listener: set_extra_try_arguments 08:59:54 INFO - [mozharness: 2016-09-19 15:59:54.852046Z] Finished download-and-extract step (success) 08:59:54 INFO - [mozharness: 2016-09-19 15:59:54.852176Z] Running populate-webroot step. 08:59:54 INFO - Running pre-action listener: _resource_record_pre_action 08:59:54 INFO - Running main action method: populate_webroot 08:59:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:54 INFO - '--tppagecycles', 08:59:54 INFO - '7'], 08:59:54 INFO - 'tests': ['tsvgm']}}, 08:59:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['damp', 'tps']}, 08:59:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'tests': ['damp', 'tps']}, 08:59:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['dromaeo_dom']}, 08:59:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['basic_compositor_video']}, 08:59:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['a11yr', 08:59:54 INFO - 'ts_paint', 08:59:54 INFO - 'tpaint', 08:59:54 INFO - 'sessionrestore', 08:59:54 INFO - 'sessionrestore_no_auto_restore', 08:59:54 INFO - 'tabpaint']}, 08:59:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:54 INFO - 'ts_paint', 08:59:54 INFO - 'tpaint', 08:59:54 INFO - 'sessionrestore', 08:59:54 INFO - 'sessionrestore_no_auto_restore', 08:59:54 INFO - 'tabpaint']}, 08:59:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:54 INFO - 'ts_paint', 08:59:54 INFO - 'tpaint', 08:59:54 INFO - 'sessionrestore', 08:59:54 INFO - 'sessionrestore_no_auto_restore', 08:59:54 INFO - 'tabpaint']}, 08:59:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:54 INFO - 'ts_paint', 08:59:54 INFO - 'tpaint', 08:59:54 INFO - 'sessionrestore', 08:59:54 INFO - 'sessionrestore_no_auto_restore', 08:59:54 INFO - 'tabpaint']}, 08:59:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['a11yr', 08:59:54 INFO - 'ts_paint', 08:59:54 INFO - 'tpaint', 08:59:54 INFO - 'sessionrestore', 08:59:54 INFO - 'sessionrestore_no_auto_restore', 08:59:54 INFO - 'tabpaint']}, 08:59:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['a11yr', 08:59:54 INFO - 'ts_paint', 08:59:54 INFO - 'tpaint', 08:59:54 INFO - 'sessionrestore', 08:59:54 INFO - 'sessionrestore_no_auto_restore', 08:59:54 INFO - 'tabpaint']}, 08:59:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['tsvgx', 08:59:54 INFO - 'tsvgr_opacity', 08:59:54 INFO - 'tart', 08:59:54 INFO - 'tscrollx', 08:59:54 INFO - 'cart']}, 08:59:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:54 INFO - 'tsvgr_opacity', 08:59:54 INFO - 'tart', 08:59:54 INFO - 'tscrollx', 08:59:54 INFO - 'cart']}, 08:59:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'talos_options': ['--disable-e10s'], 08:59:54 INFO - 'tests': ['tp5o']}, 08:59:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'tests': ['tp5o']}, 08:59:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'talos_options': ['--disable-e10s', 08:59:54 INFO - '--xperf_path', 08:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:54 INFO - 'tests': ['tp5n']}, 08:59:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:54 INFO - 'talos_options': ['--xperf_path', 08:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:54 INFO - 'tests': ['tp5n']}}, 08:59:54 INFO - 'talos.zip': {'path': '', 08:59:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:54 INFO - Running post-action listener: _resource_record_post_action 08:59:54 INFO - [mozharness: 2016-09-19 15:59:54.871258Z] Finished populate-webroot step (success) 08:59:54 INFO - [mozharness: 2016-09-19 15:59:54.871401Z] Running create-virtualenv step. 08:59:54 INFO - Running pre-action listener: _resource_record_pre_action 08:59:54 INFO - Running main action method: create_virtualenv 08:59:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:59:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:54 INFO - Using real prefix '/tools/python27' 08:59:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:58 INFO - Installing pip.................done. 08:59:58 INFO - Return code: 0 08:59:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:58 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 08:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:58 INFO - 'HOME': '/Users/cltbld', 08:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:58 INFO - 'LOGNAME': 'cltbld', 08:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:58 INFO - 'MOZ_NO_REMOTE': '1', 08:59:58 INFO - 'NO_EM_RESTART': '1', 08:59:58 INFO - 'PAGER': '/bin/cat', 08:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:58 INFO - 'PWD': '/builds/slave/test', 08:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:58 INFO - 'SHELL': '/bin/bash', 08:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 08:59:58 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:58 INFO - 'USER': 'cltbld', 08:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:58 INFO - 'XPC_FLAGS': '0x0', 08:59:58 INFO - 'XPC_SERVICE_NAME': '0', 08:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:59:58 INFO - Cleaning up... 08:59:58 INFO - Return code: 0 08:59:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:58 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 08:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:58 INFO - 'HOME': '/Users/cltbld', 08:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:58 INFO - 'LOGNAME': 'cltbld', 08:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:58 INFO - 'MOZ_NO_REMOTE': '1', 08:59:58 INFO - 'NO_EM_RESTART': '1', 08:59:58 INFO - 'PAGER': '/bin/cat', 08:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:58 INFO - 'PWD': '/builds/slave/test', 08:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:58 INFO - 'SHELL': '/bin/bash', 08:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 08:59:58 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:58 INFO - 'USER': 'cltbld', 08:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:58 INFO - 'XPC_FLAGS': '0x0', 08:59:58 INFO - 'XPC_SERVICE_NAME': '0', 08:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 INFO - Downloading/unpacking psutil>=3.1.1 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 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 09:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:02 INFO - Installing collected packages: psutil 09:00:02 INFO - Running setup.py install for psutil 09:00:02 INFO - building 'psutil._psutil_osx' extension 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 INFO - building 'psutil._psutil_posix' extension 09:00:02 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 09:00:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:00:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:00:03 INFO - ^ 09:00:03 INFO - 1 warning generated. 09:00:03 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 09:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:03 INFO - Successfully installed psutil 09:00:03 INFO - Cleaning up... 09:00:03 INFO - Return code: 0 09:00:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:00:03 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')]} 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:03 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')]} 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:03 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:03 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 09:00:03 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 09:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:03 INFO - 'HOME': '/Users/cltbld', 09:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:03 INFO - 'LOGNAME': 'cltbld', 09:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:03 INFO - 'MOZ_NO_REMOTE': '1', 09:00:03 INFO - 'NO_EM_RESTART': '1', 09:00:03 INFO - 'PAGER': '/bin/cat', 09:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:03 INFO - 'PWD': '/builds/slave/test', 09:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:03 INFO - 'SHELL': '/bin/bash', 09:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:03 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:03 INFO - 'USER': 'cltbld', 09:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:03 INFO - 'XPC_FLAGS': '0x0', 09:00:03 INFO - 'XPC_SERVICE_NAME': '0', 09:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:00:03 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 09:00:03 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 09:00:03 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 09:00:03 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 09:00:03 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 09:00:03 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 09:00:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:00:06 INFO - Installing collected packages: mozsystemmonitor 09:00:06 INFO - Running setup.py install for mozsystemmonitor 09:00:06 INFO - Successfully installed mozsystemmonitor 09:00:06 INFO - Cleaning up... 09:00:06 INFO - Return code: 0 09:00:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:00:06 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')]} 09:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:06 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')]} 09:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:06 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:06 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 09:00:06 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 09:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:06 INFO - 'HOME': '/Users/cltbld', 09:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:06 INFO - 'LOGNAME': 'cltbld', 09:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:06 INFO - 'MOZ_NO_REMOTE': '1', 09:00:06 INFO - 'NO_EM_RESTART': '1', 09:00:06 INFO - 'PAGER': '/bin/cat', 09:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:06 INFO - 'PWD': '/builds/slave/test', 09:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:06 INFO - 'SHELL': '/bin/bash', 09:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:06 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:06 INFO - 'USER': 'cltbld', 09:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:06 INFO - 'XPC_FLAGS': '0x0', 09:00:06 INFO - 'XPC_SERVICE_NAME': '0', 09:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:00:06 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 09:00:06 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 09:00:06 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 09:00:06 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 09:00:06 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 09:00:06 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 09:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:00:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:00:09 INFO - warning: no files found matching '*.txt' 09:00:09 INFO - no previously-included directories found matching 'build' 09:00:09 INFO - no previously-included directories found matching 'dist' 09:00:09 INFO - no previously-included directories found matching '.git*' 09:00:09 INFO - Installing collected packages: jsonschema, functools32 09:00:09 INFO - Running setup.py install for functools32 09:00:09 INFO - warning: no files found matching '*.txt' 09:00:09 INFO - no previously-included directories found matching 'build' 09:00:09 INFO - no previously-included directories found matching 'dist' 09:00:09 INFO - no previously-included directories found matching '.git*' 09:00:09 INFO - Successfully installed jsonschema functools32 09:00:09 INFO - Cleaning up... 09:00:09 INFO - Return code: 0 09:00:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:09 INFO - 'HOME': '/Users/cltbld', 09:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:09 INFO - 'LOGNAME': 'cltbld', 09:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:09 INFO - 'MOZ_NO_REMOTE': '1', 09:00:09 INFO - 'NO_EM_RESTART': '1', 09:00:09 INFO - 'PAGER': '/bin/cat', 09:00:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:09 INFO - 'PWD': '/builds/slave/test', 09:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:09 INFO - 'SHELL': '/bin/bash', 09:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:09 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:09 INFO - 'USER': 'cltbld', 09:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:09 INFO - 'XPC_FLAGS': '0x0', 09:00:09 INFO - 'XPC_SERVICE_NAME': '0', 09:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:00:10 INFO - Cleaning up... 09:00:10 INFO - Return code: 0 09:00:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00:10 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')]} 09:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:10 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')]} 09:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:10 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:10 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 09:00:10 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 09:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:10 INFO - 'HOME': '/Users/cltbld', 09:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:10 INFO - 'LOGNAME': 'cltbld', 09:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:10 INFO - 'MOZ_NO_REMOTE': '1', 09:00:10 INFO - 'NO_EM_RESTART': '1', 09:00:10 INFO - 'PAGER': '/bin/cat', 09:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:10 INFO - 'PWD': '/builds/slave/test', 09:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:10 INFO - 'SHELL': '/bin/bash', 09:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:10 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:10 INFO - 'USER': 'cltbld', 09:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:10 INFO - 'XPC_FLAGS': '0x0', 09:00:10 INFO - 'XPC_SERVICE_NAME': '0', 09:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:00:10 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 09:00:10 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 09:00:10 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 09:00:10 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 09:00:10 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 09:00:10 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 09:00:12 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00:12 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 09:00:12 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 09:00:12 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 09:00:12 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 09:00:12 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 09:00:12 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 09:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00:13 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 09:00:13 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 09:00:13 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 09:00:13 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 09:00:13 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 09:00:13 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 09:00:13 INFO - Downloading docopt-0.6.1.tar.gz 09:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:14 INFO - Running setup.py install for blobuploader 09:00:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:14 INFO - Running setup.py install for requests 09:00:14 INFO - Running setup.py install for docopt 09:00:14 INFO - Successfully installed blobuploader requests docopt 09:00:14 INFO - Cleaning up... 09:00:14 INFO - Return code: 0 09:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:14 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:14 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 09:00:14 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 09:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:14 INFO - 'HOME': '/Users/cltbld', 09:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:14 INFO - 'LOGNAME': 'cltbld', 09:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:14 INFO - 'MOZ_NO_REMOTE': '1', 09:00:14 INFO - 'NO_EM_RESTART': '1', 09:00:14 INFO - 'PAGER': '/bin/cat', 09:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:14 INFO - 'PWD': '/builds/slave/test', 09:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:14 INFO - 'SHELL': '/bin/bash', 09:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:14 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:14 INFO - 'USER': 'cltbld', 09:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:14 INFO - 'XPC_FLAGS': '0x0', 09:00:14 INFO - 'XPC_SERVICE_NAME': '0', 09:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-GcZuec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-LfCunr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-J4BAz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-OqKAe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-QgePKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-cWZ5Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-wNQI_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:15 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-nh4jYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HkLNQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-zEwc3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-wqqAJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-RmbDaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-rIScpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-vc02Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-O2_00O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-LV9LE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:16 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-oxalpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:16 INFO - Running setup.py install for manifestparser 09:00:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozcrash 09:00:17 INFO - Running setup.py install for mozdebug 09:00:17 INFO - Running setup.py install for mozdevice 09:00:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozfile 09:00:17 INFO - Running setup.py install for mozhttpd 09:00:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozinfo 09:00:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for mozInstall 09:00:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for mozleak 09:00:18 INFO - Running setup.py install for mozlog 09:00:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for moznetwork 09:00:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for mozprocess 09:00:18 INFO - Running setup.py install for mozprofile 09:00:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for mozrunner 09:00:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:19 INFO - Running setup.py install for mozscreenshot 09:00:19 INFO - Running setup.py install for moztest 09:00:19 INFO - Running setup.py install for mozversion 09:00:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:19 INFO - Cleaning up... 09:00:19 INFO - Return code: 0 09:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:19 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')]} 09:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:19 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')]} 09:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:19 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:19 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 09:00:19 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 09:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:19 INFO - 'HOME': '/Users/cltbld', 09:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:19 INFO - 'LOGNAME': 'cltbld', 09:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:19 INFO - 'MOZ_NO_REMOTE': '1', 09:00:19 INFO - 'NO_EM_RESTART': '1', 09:00:19 INFO - 'PAGER': '/bin/cat', 09:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:19 INFO - 'PWD': '/builds/slave/test', 09:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:19 INFO - 'SHELL': '/bin/bash', 09:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:19 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:19 INFO - 'USER': 'cltbld', 09:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:19 INFO - 'XPC_FLAGS': '0x0', 09:00:19 INFO - 'XPC_SERVICE_NAME': '0', 09:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:19 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-_ILX1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:19 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-p4J9Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-4zcYAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-aMsnKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-gcL0Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xIepwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-1Rmlw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-n7415k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-OJtVLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-nycXfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-2cssgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:21 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)) 09:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-IKqQH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:21 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)) 09:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-AT0oSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:21 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)) 09:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-lYrGit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:21 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)) 09:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-uGtf4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:21 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)) 09:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-5uy1Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:21 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)) 09:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-q6hXXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:21 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)) 09:00:21 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)) 09:00:21 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)) 09:00:21 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)) 09:00:21 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)) 09:00:21 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)) 09:00:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:24 INFO - Downloading blessings-1.6.tar.gz 09:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:24 INFO - Installing collected packages: blessings 09:00:24 INFO - Running setup.py install for blessings 09:00:24 INFO - Successfully installed blessings 09:00:24 INFO - Cleaning up... 09:00:24 INFO - Return code: 0 09:00:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:24 INFO - Reading from file tmpfile_stdout 09:00:24 INFO - Current package versions: 09:00:24 INFO - blessings == 1.6 09:00:24 INFO - blobuploader == 1.2.4 09:00:24 INFO - docopt == 0.6.1 09:00:24 INFO - functools32 == 3.2.3-2 09:00:24 INFO - jsonschema == 2.5.1 09:00:24 INFO - manifestparser == 1.1 09:00:24 INFO - mozInstall == 1.12 09:00:24 INFO - mozcrash == 0.17 09:00:24 INFO - mozdebug == 0.1 09:00:24 INFO - mozdevice == 0.48 09:00:24 INFO - mozfile == 1.2 09:00:24 INFO - mozhttpd == 0.7 09:00:24 INFO - mozinfo == 0.9 09:00:24 INFO - mozleak == 0.1 09:00:24 INFO - mozlog == 3.4 09:00:24 INFO - moznetwork == 0.27 09:00:24 INFO - mozprocess == 0.23 09:00:24 INFO - mozprofile == 0.28 09:00:24 INFO - mozrunner == 6.12 09:00:24 INFO - mozscreenshot == 0.1 09:00:24 INFO - mozsystemmonitor == 0.3 09:00:24 INFO - moztest == 0.7 09:00:24 INFO - mozversion == 1.4 09:00:24 INFO - psutil == 3.1.1 09:00:24 INFO - requests == 1.2.3 09:00:24 INFO - wsgiref == 0.1.2 09:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:24 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:24 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 09:00:24 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 09:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:24 INFO - 'HOME': '/Users/cltbld', 09:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:24 INFO - 'LOGNAME': 'cltbld', 09:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:24 INFO - 'MOZ_NO_REMOTE': '1', 09:00:24 INFO - 'NO_EM_RESTART': '1', 09:00:24 INFO - 'PAGER': '/bin/cat', 09:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:24 INFO - 'PWD': '/builds/slave/test', 09:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:24 INFO - 'SHELL': '/bin/bash', 09:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:24 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:24 INFO - 'USER': 'cltbld', 09:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:24 INFO - 'XPC_FLAGS': '0x0', 09:00:24 INFO - 'XPC_SERVICE_NAME': '0', 09:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 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)) 09:00:25 INFO - Cleaning up... 09:00:25 INFO - Return code: 0 09:00:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00:25 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')]} 09:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:25 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')]} 09:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:25 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 0x1039fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103973570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807adb9730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, '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.lYMHBIQp73/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.MzjYEOBKKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 09:00:25 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 09:00:25 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 09:00:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:25 INFO - 'HOME': '/Users/cltbld', 09:00:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:25 INFO - 'LOGNAME': 'cltbld', 09:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:25 INFO - 'MOZ_NO_REMOTE': '1', 09:00:25 INFO - 'NO_EM_RESTART': '1', 09:00:25 INFO - 'PAGER': '/bin/cat', 09:00:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:25 INFO - 'PWD': '/builds/slave/test', 09:00:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:25 INFO - 'SHELL': '/bin/bash', 09:00:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:25 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:25 INFO - 'USER': 'cltbld', 09:00:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:25 INFO - 'XPC_FLAGS': '0x0', 09:00:25 INFO - 'XPC_SERVICE_NAME': '0', 09:00:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:25 INFO - Cleaning up... 09:00:25 INFO - Return code: 0 09:00:25 INFO - Running post-action listener: _resource_record_post_action 09:00:25 INFO - Running post-action listener: _start_resource_monitoring 09:00:25 INFO - Starting resource monitoring. 09:00:25 INFO - [mozharness: 2016-09-19 16:00:25.312756Z] Finished create-virtualenv step (success) 09:00:25 INFO - [mozharness: 2016-09-19 16:00:25.313807Z] Running install step. 09:00:25 INFO - Running pre-action listener: _resource_record_pre_action 09:00:25 INFO - Running main action method: install 09:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:25 INFO - Reading from file tmpfile_stdout 09:00:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:25 INFO - Reading from file tmpfile_stdout 09:00:25 INFO - Output received: 09:00:25 INFO - Usage: mozinstall [options] installer 09:00:25 INFO - Options: 09:00:25 INFO - -h, --help show this help message and exit 09:00:25 INFO - -d DEST, --destination=DEST 09:00:25 INFO - Directory to install application into. [default: 09:00:25 INFO - "/builds/slave/test"] 09:00:25 INFO - --app=APP Application being installed. [default: firefox] 09:00:25 INFO - mkdir: /builds/slave/test/build/application 09:00:25 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'] 09:00:25 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 09:00:57 INFO - Reading from file tmpfile_stdout 09:00:57 INFO - Output received: 09:00:57 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:00:57 INFO - Running post-action listener: _resource_record_post_action 09:00:57 INFO - [mozharness: 2016-09-19 16:00:57.706901Z] Finished install step (success) 09:00:57 INFO - [mozharness: 2016-09-19 16:00:57.707045Z] Running run-tests step. 09:00:57 INFO - Running pre-action listener: _resource_record_pre_action 09:00:57 INFO - Running main action method: run_tests 09:00:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:00:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:00:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:00:57 INFO - 2016-09-19 09:00:57.722 screenresolution[1989:11117] starting screenresolution argv=screenresolution get 09:00:57 INFO - 2016-09-19 09:00:57.724 screenresolution[1989:11117] Display 0: 1600x1200x32@60 09:00:57 INFO - 2016-09-19 09:00:57.730 screenresolution[1990:11119] starting screenresolution argv=screenresolution list 09:00:57 INFO - Available Modes on Display 0 09:00:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:00:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:00:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:00:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:00:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:00:57 INFO - Intel Iris: 09:00:57 INFO - Chipset Model: Intel Iris 09:00:57 INFO - Type: GPU 09:00:57 INFO - Bus: Built-In 09:00:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:00:57 INFO - Vendor: Intel (0x8086) 09:00:57 INFO - Device ID: 0x0a2e 09:00:57 INFO - Revision ID: 0x0009 09:00:57 INFO - Displays: 09:00:57 INFO - Display: 09:00:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:00:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:00:57 INFO - Display Serial Number: 1600x1200 60 09:00:57 INFO - Main Display: Yes 09:00:57 INFO - Mirror: Off 09:00:57 INFO - Online: Yes 09:00:57 INFO - Rotation: Supported 09:00:57 INFO - Return code: 0 09:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:57 INFO - Python 2.7.3 09:00:57 INFO - Return code: 0 09:00:57 INFO - grabbing minidump binary from tooltool 09:00:57 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')]} 09:00:57 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 0x103811d30>, '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 0x103677db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103809b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:57 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 09:00:57 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 09:00:57 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 09:00:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:58 INFO - Return code: 0 09:00:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:00:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:00:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 09:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --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 09:00:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYMHBIQp73/Render', 09:00:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:58 INFO - 'HOME': '/Users/cltbld', 09:00:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:58 INFO - 'LOGNAME': 'cltbld', 09:00:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:58 INFO - 'MOZ_NO_REMOTE': '1', 09:00:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:58 INFO - 'NO_EM_RESTART': '1', 09:00:58 INFO - 'PAGER': '/bin/cat', 09:00:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:58 INFO - 'PWD': '/builds/slave/test', 09:00:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:58 INFO - 'SHELL': '/bin/bash', 09:00:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MzjYEOBKKo/Listeners', 09:00:58 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 09:00:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:58 INFO - 'USER': 'cltbld', 09:00:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:58 INFO - 'XPC_FLAGS': '0x0', 09:00:58 INFO - 'XPC_SERVICE_NAME': '0', 09:00:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 09:00:58 INFO - mozversion application_buildid: 20160919065229 09:00:58 INFO - mozversion application_changeset: 5dddbefdf759f09b1411f33fa0920835b919fc81 09:00:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:00:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:58 INFO - mozversion application_name: Firefox 09:00:58 INFO - mozversion application_remotingname: firefox-dev 09:00:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:00:58 INFO - mozversion application_vendor: Mozilla 09:00:58 INFO - mozversion application_version: 51.0a2 09:00:58 INFO - mozversion platform_buildid: 20160919065229 09:00:58 INFO - mozversion platform_changeset: 5dddbefdf759f09b1411f33fa0920835b919fc81 09:00:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:00:58 INFO - mozversion platform_version: 51.0a2 09:00:58 INFO - using testdate: 1474300858 09:00:58 INFO - actual date: 1474300858 09:00:58 INFO - starting webserver on 'localhost:49391' 09:00:58 INFO - SUITE-START | Running 2 tests 09:00:58 INFO - TEST-START | dromaeo_css 09:00:58 INFO - operating with platform_type : mac_ 09:00:58 INFO - Initialising browser for dromaeo_css test... 09:00:58 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpkeN1fX/profile http://localhost:49391/getInfo.html) 09:01:01 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 09:01:01 INFO - PROCESS | 2000 | colorDepth:24 09:01:01 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 09:01:01 INFO - PROCESS | 2000 | __metrics 09:01:01 ERROR - PROCESS | 2000 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 09:01:02 INFO - TEST-INFO | 2000: exit 0 09:01:02 INFO - Browser initialized. 09:01:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:01:02 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpkeN1fX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:14 INFO - PROCESS | 2003 | RSS: Main: 224890880 09:01:14 INFO - PROCESS | 2003 | 09:02:03 INFO - PROCESS | 2003 | 1474300923897 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] 09:04:16 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49391/tests/dromaeo/cssquery-ext.html) 09:04:17 INFO - PROCESS | 2003 | RSS: Main: 236838912 09:04:17 INFO - PROCESS | 2003 | 09:07:20 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-ext.html (next: http://localhost:49391/tests/dromaeo/cssquery-jquery.html) 09:07:20 INFO - PROCESS | 2003 | RSS: Main: 247279616 09:07:20 INFO - PROCESS | 2003 | 09:10:22 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49391/tests/dromaeo/cssquery-mootools.html) 09:10:23 INFO - PROCESS | 2003 | RSS: Main: 252452864 09:10:23 INFO - PROCESS | 2003 | 09:13:25 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49391/tests/dromaeo/cssquery-prototype.html) 09:13:25 INFO - PROCESS | 2003 | RSS: Main: 253624320 09:13:25 INFO - PROCESS | 2003 | 09:16:28 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49391/tests/dromaeo/cssquery-yui.html) 09:16:29 INFO - PROCESS | 2003 | RSS: Main: 258170880 09:16:29 INFO - PROCESS | 2003 | 09:19:31 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-yui.html (next: http://localhost:49391/tests/dromaeo/cssquery-dojo.html) 09:19:32 INFO - PROCESS | 2003 | RSS: Main: 259678208 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | __start_tp_report 09:19:32 INFO - PROCESS | 2003 | _x_x_mozilla_page_load 09:19:32 INFO - PROCESS | 2003 | _x_x_mozilla_page_load_details 09:19:32 INFO - PROCESS | 2003 | |i|pagename|runs| 09:19:32 INFO - PROCESS | 2003 | |0;dojo.html;3468.6184519702833;3479.9304013919723;3500.7549471536995;3513.6135025147214;3537.292541491701;6001.459868611824;6040.758369665208;6074.453299203076;6091.78678746244;6125.5712100153005;6026.819195424133;6087.20866287382;6089.45194932456;6101.572889897709;6136;5408.675479471234;5451.536619387357;5454.754536045868;5524.06090964537;5547.306586676666;5502.119660854264;5515.669059856401;5520.447955204488;5528.806491772789;5600.747966341524;5360.437154098822;5370.248165256867;5419.972900135494;5516.724163791794;5530.806421775239;5439.428859969706;5458.399576046631;5474.863128421782;5480.177973303997;5503.257060296849;5298.761555729963;5442.102053161224;5464.6994415307145;5471.808486702986;5492.917606235909;5879.647221166743;5894.115882617599;6015.3383127855905;6117.877642447126;6153.630782153085;6317.1156038154695;6328.778492752777;6367.522435817332;6386.8722625547225;6390.872182556369;6484.351564843525;6502.252240992299;6507.089007538948;6526.249481309663;6539.901901471481;5936.347001829795;6002.969985150134;6049.153118563405;6123.510119190454;6181.6600086995195;6533.542652014314;6543.5419520633095;6543.967280163664;6566;6580.11168492257;6305.684715764193;6305.968470157712;6315.684215789192;6317.905231421532;6318.210223722035;6174.691265436711;6246.3441338659695;6272.843178920563;6421.068945002949;6430.7749228776765;6243.562950593415;6277.811665650038;6317;6318.399752023551;6347.714352854133;6302.212223472066;6319.968400158062;6324.494040476751;6328.145700330489;6337.683115844189;4904.926426103611;4917.877053073702;5041.21861111521;5061.266116413173;5118.667286626357;4202.495700515897;4516.299973504112;4523.977380113144;4542.636589072867;4590.1278757036725;6046.939530604637;6126.663033533109;6159.876802463926;6188.721507532172;6212.658303793244;6219.720112594944;6310.495160387158;6447.903281450782;6490.188726409199;6672.032555279555;6111.327753947062;6142.9864072428445;6149.538784591084;6156.8917594832465;6158.538109641795;5573;5576.972115139399;5592.748326325325;5594.524465420485;5617.747201375948;5536.75084621193;6371.553991220755;6434.839129021625;6574.079628851869;6619.172603424572;6287.748490060347;6322.652254125883;6396.168498095218;6476.6114033158165;6494.642794646151;6535.803925882231;6598.736050557924;6622.602643841385;6623.304553021863;6625.701843417154;6205.782797602063;6289.7169627365965;6342.7780027700655;6345.7144428499905;6345.777897773556;5207.71357575337;6209.937900620936;6281.434670879643;6282.277538083179;6320.62076275425;6288.496920246461;6293.653849038347;6298.968505157445;6302.779402720883;6308.369163083655;6181.907271390843;6257;6271.62370257786;6288.937110628835;6291.716872740829;6061.878762424815;6103.847403814762;6110.953680641605;6115.909724157069;6201.472874805692;6267.059941008885;6300.621962682254;6302.212223472066;6316.557840951089;6334.429901308904;5295.602829787705;6212.192414986023;6267.341929097562;6271.811845644638;6275.121482992294 09:19:32 INFO - PROCESS | 2003 | |1;ext.html;486.46488862251505;497.08536293220465;514.4598171919483;523.6568202560435;542.946683434138;38612.61387386125;40420.19159616806;40525;40693.186136277334;40694.59305406945;41398.793006034924;41842.58157418425;41866.790666046625;41987.16025679484;42110;9757.975412581683;9828.213742900587;9830.459324737136;9830.803383932318;9846.1630761385;8347.248747612713;9746.512674366253;9788.706338809847;9800.90199098007;9810.656627018056;9746.46394448305;9782.608695652165;9786.755331116708;9794;9818.067283608081;9737.756556086084;9770.804583908353;9785.706428807147;9808.46053467059;9814.312998090136;9755.707328780149;9807.90192098077;9839.803203935953;9844.852327215098;9846.458444785534;39541.01147471307;39887.4016889744;39904.00239993994;39937.80186594378;39966.200675986605;3394.8642054317797;3539.80531070791;3553.751237413382;3995.2808494471274;4093.3450647896193;29824.403511929857;30393.696063039308;30489;30573.694263057307;30863.53704694409;3239.5626590410466;3286.260591366947;3299.6700329967052;3299.736021118305;3305.5702758641223;497578;506489.4675526636;507693;508089;512242;33115.00654980355;34088.14779630529;58355.12467312994;58642.706786465795;58803.41196588065;31582.842085789423;33949.83025084859;34214.82892585521;34369;34458.82770586181;15064.774028389584;15133.924330378497;15272.38910443592;15281.46514871974;15289.694206115815;9490.90509094914;11495.42522873853;12666.113372063866;12873.420696068511;13071.869281307256;7579.317861392501;7703;7739.845203096019;7767.495112817649;7797.571133587707;3202.711755941976;3251.512273159045;3251.8048917065053;3259.445894197992;3279.1474216703828;928.2898582584328;950.4867371619387;958.3722661656626;960.8750862387984;1058.957641694339;30040.399192016037;30340.938067167986;30410.47947602611;30660.38679226403;31784.364312713617;900.5542256583034;1060.3690803971624;1073.457903758597;1079.2499213046858;1093.169191414515;14145.504907328193;15359.462418815288;15493.535193944199;15547.833912456612;15814.920925395529;692778;701082;701181;702594;704702;56329.87340253172;56636;56723.86552268932;56807.43192568104;56882.71558642263;1345.757763602561;1366.3987845348015;1387.084524214014;1387.7293927684207;1393.0736060519641;24378.634320485562;28947.855260724406;29115.126546203646;29741.702582974758;30332.786688533095;49024.50975490342;49300.50699493103;49431.75284123556;49554;49654.751726241135;599167;599372;600412;602363;603158;26520.734792651827;26569.734302656725;26915.192544223704;26941;26994.595081073407;43728.56271437372;43844.34233486564;43907;46105.30842037439;47417.52582474131;38770.61229387783;38817.6118238814;39784;40451.39322910218;40600.79699601483;39017;39364.2127157461;39506;40564.594354056084;40616.79691601523;37878.8106059468;37880.62119378771;38322;38445.6155438442;38634.6136538631;32668.67331326656;33173.33653326872;34461.79383721558;35060;35126.824365878005;25791.355216119748;25849.353766155997;25855.353616159748;26160.86919565466;26296.4740705181 09:19:32 INFO - PROCESS | 2003 | |2;jquery.html;367.63604032008317;377.3208225194649;383.1436738888582;383.2679581998383;397.7633308181633;16011.999999999985;19998.10008549615;20853.37439876806;20872.582548349063;21126.683099753478;11565.248258863168;11671.883281167185;11999.460024298905;12011.579594714187;12033.75932481352;4209.305464598346;4734.502877197896;5248.501392367719;5557.166425036236;5563.471470210344;3931.351327031051;4123.546409894909;5479.4520547945285;5869.9706501467645;6135.3557876423;6211.0372892201785;6213.285472170691;6213.844653883644;6225.533085018619;6225.719842607071;5163.406208286039;5408.648437851527;6009.617787908805;6225.937740622627;6239.438450539428;5367.892642147174;5748.137779333092;6041.848953776147;6047.213862197887;6069.028955367165;13060.934695326463;13133;13235.00737444686;13286.534971276056;13306.73386532264;2297.425643589103;2363.5627408929404;2363.6572696959015;2421.055788242587;2469.1851688942784;9731.805363892683;9870.703878883573;9898.10917017472;10319.277650564463;10391.79216415675;1727.5468834255387;1804.9909750451163;1823.179569193868;1879.9508535696157;1933.3716542123725;118437.81562184355;120824.39587802092;122250;122782;124091;11537.653870383734;11678.299302041734;11788.174827761974;11834.8769410784;11846.229995050295;14681.339339729739;14767.26163691811;14784.704305913821;14804.851951480347;14860.62848428798;6989.720411183597;8622.655093796178;8773.166549177819;8807.383483156245;8890.377673562918;7337;8697.521636310064;8742.388032837767;8810.163034511712;8900.599473023729;3728.5339332583426;4537.886552836139;4607.95392046082;4632.444106707149;4687.601553867959;1588.213834152079;1690.3914590747322;1696.5164927995709;1888.6978083506847;1997.4307322413042;855.3029281135854;889.2530274569393;918.609590923868;990.029770824596;1017.760826205841;17162.970221786734;21074.789252107283;21339.46651333698;21447.249346272805;21462;894.1014280647908;921.7511271956669;934.1919239857474;953.7886883657716;989.9257555683208;10942.4528773561;11174.497147628375;11260.155488338407;11271.605493807678;11398;619754;623264;627536;628668;630465;133122;136004;140095;140718;140997;907.0385391485047;917.9173874351206;923.9630414783334;929;953.389830508489;15282.923585382003;17557.648847023243;17878.106094695475;19256.22975080981;19451.61096778085;51525.48474515207;51609.48390516197;52445.47554524559;53511.732441337546;55529;78322;79032.60483697544;81363;84255;84414.31171376661;6817.216020157745;7233.602151881487;7493.662785174789;7546.320831125225;7684.1547429783795;12471.812922806346;12797.616071517497;13086.0839741221;13332.866671333162;13399.53101641438;10765.246432749946;10865.511052002521;11098.5560577576;11187.832182517106;11502.769944600894;10484.423356715453;10746.785064298514;10791.40647264408;10815.35107893529;10903.073238774792;5108.157154069537;6248.68756562161;8780.463418901794;10550.947245263724;10588.682339529827;7158.854583266652;7350.632468376667;7425.925740742739;7459.738909138154;7600.619969001638;8850.73447796567;8907.910920890708;10071.295009349275;10098.697039088838;10399.740006499898 09:19:32 INFO - PROCESS | 2003 | |3;mootools.html;1523.6114790728366;1547.2031903569662;1769.4868488138432;1788.0523322639006;1868.6732419981813;7506.624668766561;8186.877196842052;8441.49351038938;9197.310201734872;9220.8616870747;8278.213569710868;8602.139786021395;8691.956540217307;9016.504092274923;9036.63853445863;2367.029517897662;2398.796102331304;2404.8917798699013;2410.7468715784853;2413.6017557103146;2369.2655276864143;2392.3660230039054;2412.7587241275905;2413.1312727418117;2415.6497307890345;2032.4613977296028;2277.749447560767;2395.2933884504027;2400.255920664591;2408.8313818032743;2356.882155892216;2376.857388556692;2382.9880850595723;2397.436602398435;2400.7959323457526;2353.0587764894008;2354.7174339079247;2364.900321350563;2367.5501654685554;2381.618940969454;9004.00955894851;9024.548772561411;9050.592723327467;9054.094590540959;9078.046805085436;5284.339457567804;5349.732513374354;5416.783328666848;5423.2136340230445;5437.102878025121;3398.218409765768;3425.1950791563963;3459.3600183965796;3521.4365701487895;3566.946495802565;1091.497910960959;1094.2340361746808;1105.3312745788842;1111.5164903267105;1114.5263263113225;11773.941130294379;11859.999999999915;11899.940500297444;11913.642590722293;11920.761584768343;4551.340055691906;4616.515265897033;4766;4780.808767649255;4817.084753896748;8585;9218.53907304632;10004.749881252881;10084.344517606332;10090.445025523666;5369.677819330853;5380.838574842761;5382.219578161144;5383.2194331821665;5391.272178255886;4455.576720211575;4579.107074120515;4790.808367665254;4848.806047758121;4935.358403407606;3920.4707364506;3949.249642567903;4020.035191554006;4038.495188101487;4049.53430355507;1225.662942690767;1302.4529697527062;1314.4413624209672;1328.3092791748236;1347.5553067487706;767.7850201943464;894.4812009034745;904.0462312260628;925.121134921827;933.8179055084329;6013.939860601426;6047.425494578008;6081.17904082952;6088.817335479854;6351.110844481776;886.4415418286438;890.1454603580506;903.8056817784208;926.7080869526078;957.5499515227832;3915.2169566086327;3996.3805610130476;4027.315356389362;4046.5346485154582;4092.5088989320875;10576.149173894537;11045.668629941114;11052.392118433563;11058.723531911606;11071.280366776135;9302.395344302598;10904.400257985886;11015;11033.724156896142;11054.170937179744;7053.365197132282;8277.751667449986;8357.498550087013;8406.369522285853;8455.196756308264;4920.507949205051;5758.3090029196765;5928.614640048383;6071.939280607137;6080;8808.867866981873;9280.907190928005;10256.53845576936;10312.27814053009;10321.277510574188;9465.47939863314;10439.739006524898;10456.738581535523;10539.78920421572;10601.46992650349;7113.612845495079;7354.77935661931;7398.038255027027;7669.7315593953945;7835.960820195863;8342.79143021405;8584.957075214834;8596.312295016258;8598.011228708778;8600.053994060523;7532.661030253761;7656.5788881609815;7681.270279323456;7780.805479863048;7788.221177882167;7399.59302238382;7509.474336796372;7534.623268836426;7535.171131175457;7625.199354067743;6967.372936435745;7142.035825163536;7145.749898753519;7152.284771522806;7180.640967951686;4460.710053846489;4979.3526841510375;5087.567556757569;5094.923576146435;5141.331626888481;5137.743112844418;5148.073346797612;5152.30443890085;5190.480951904779;5215.687058776485 09:19:32 INFO - PROCESS | 2003 | |4;prototype.html;306.72088399556395;310.2956289223462;318.10136364769534;321.0897106702498;321.48883275591805;5124.564412024983;5439.347278326596;5640.266765320508;5728.169415434764;5755.482006619409;4675.8363457279;4693.671442998992;5433.782648694058;5550.306211723535;5587.888242235153;3575.410057340536;3726.31063253299;4244.1511697660435;4265.936010959838;4268;3323.667633236669;4033.4353190553347;4270.145970805851;4273.829046838123;4281.550437204095;3672.5592928848578;4207.15856828634;4211.915761684764;4227.767472789011;4267.807948642303;4208.789560521977;4227.471566054228;4241.36379543068;4258.68059895509;4260.595243451867;3240.4329242382487;3476.148343655795;3651.8539258429632;3674.2651469705897;3698.9630103698887;4544.840930567414;5298.443663415363;5393.487618676219;5418.322709661293;5469.343678758534;4070.4911886014247;4189.162167566499;4734.455537613184;4907.018596280723;4930.950690493085;4886.045581767286;5108.64239503235;5922.3485416604135;5953.761849526014;5965.105234214902;3357.798532088058;3879.709021823346;3935.390014547721;4074.8777536673947;4101.630853223194;5084.949150508522;5550.27846379968;6208.820324138399;6221.9377806222265;6222.657753823583;3396.6433524479576;3570.643155600907;3975.4495746658827;4122.649574786117;4130.855420060344;3128.530720391959;4005;4098.631123198927;4177.874663760092;4222.619964203236;4546.090781843644;4627.8611641650805;4892;4894.951050489521;4927.408710954708;4702.694324868872;5173.482651734872;5933.554983376178;5952.363100147408;5971.552133589998;1350.7568637645318;1411.9152850828777;1427.6074079628186;1431.6134643646158;1445.4507287230786;931.8788557487484;947.0311977472967;958.3148049144755;959.5538074795254;975.4439969217478;5577.107662773937;5591.505309181762;5592.356878958891;5593.720313984284;5602.635828671123;5253.133233016586;5348.171033489815;6067.362926892701;6093.451589356979;6113.358097399798;5299.6025298102795;5524.917126243109;5539.390667026624;5570.777168913279;5580.748866301026;2614.3856193794445;2691.371720109345;2708.9864550677516;2726;2754.9586756198673;4642.442906851199;4860.708357498562;5262.421133675292;5318.9202161967605;5342.305500284938;5226.850092979538;5562.805301814417;5854.360778981892;6358.650274234961;6418.839529011812;6076.453119219292;6454.225492940971;6479.838004049937;6495.512836537184;6523.64119973406;5133.974330128475;5649.858753531194;5964.642121472725;6163.445289923929;6256.529715516759;5457.7271136443815;5594.356648985418;5640.125780504029;6090.665013424127;6161.291451483136;6051.5461340400525;6121.357257488078;6405.423511883952;6430.549861509837;6490.448311893542;4013.9162426144194;4014.3777714454304;4054.594540545922;4064.898377540585;4066.53234877981;5534.640248383842;5664.581626331468;5880.970595147168;6042.546808989256;6160.291566469913;5168.914527949022;5171.3277273954145;5817;5920.467157955804;6022.909656355246;4804.918893249131;5977.9103313451205;6030.758769649165;6036.517078633787;6051.213342265477;5669.234653321749;5831.617661756256;5841.932985182813;5894.0274854650215;5908.734106965283;5062;5327.493888080626;6007.897235967376;6044.33512313654;6045.939540604538;4834.395700537433;5214.661047031931;5584.329880414376;5879.618289701831;5891.203183029217 09:19:32 INFO - PROCESS | 2003 | |5;yui.html;723.558629236166;764.7017663111387;767.8656235158846;804.9235322644347;826.495837539101;15465;15680.607984800386;15920.283587238573;15960.04239745616;16024.278907449163;14236.430542778277;14286.499972500964;14355.06692065015;14360.425582976668;14385.712285754278;816.4121832280763;831.2311112221201;874.5190145420025;878.3193025405299;889.8175873945826;848.3086284677998;854.7179430787857;875.0767939823484;875.3741075131312;883.575883575884;903.4218100415707;909.5952301225957;912.393258483108;913.4427998920686;918.8101408675781;887.2901678657081;892.384254864145;895.1853813030111;901.8016036471965;902.4269588811119;676.067027502049;677.4952660268132;678.3860606151392;681.2778454837838;682.1166589266911;13036.674083147902;13079.41142648583;13112.409941552653;13133.212007279593;13144.605661830064;14128.50550230737;14221.360038798279;14398.064125831892;14567.271636418243;14659;11792.914660219367;11894.643160705193;11956.701082473008;11998.58004969822;12447.502099915993;3754.699624030071;3834.5015148030857;3848.826802793881;3853.903652408684;3882.9805850970565;131304;131971;134022.659773402;134575;134736.6526334734;9464.432134071978;10950.3429794211;10975.615853445091;11085.889141108648;11097.611583594535;22177.778222217894;22267.55464890693;22271.22050728249;22285;22286.108555657593;7586.431017673696;7864.882026769603;8017.518948863087;8033.1163572007035;8158.755237342889;4321.805518751664;4393.868183954486;4416.138852923713;4486.282194848808;4527.320901864747;2796.9160925172278;3606.5311509503595;3606.711463082947;3606.9278614427562;3801.201747633028;694.7151667816272;708.624429052603;711.9572825630479;722.5411863466736;723.3381455967835;429.63695677152754;554.8834744703577;656.7143292667705;661.9834504137435;687.2817905288985;8975.910240897507;9422.481763503074;9534.28492863038;9537.61849526025;9589.184919281939;564.2777245126163;659.9010148477671;674.3020973292619;684.4558575932047;684.4592771710293;4335.458067741532;4547.840825571089;4645.007939757742;4705.976470117696;4710.52894710533;90897;91424;92041.07958920459;135960.64039359678;153214;87007;94606;112662.31006534908;120509;122793;104551;108105;108602.45698771614;110011;111354;8654.567271636268;9020.684276050306;9065.77335566616;9071.727848164566;9198.724038278862;49079.26381104215;58028.4197158023;62624;64366.67816661074;64930.675346622964;76531;91488.62767058366;91591.54204228937;93723.06276937143;98421;10618.309809862334;12704.936475317565;12816.166949148275;13365.198088114745;13465.394057267642;14467;14714.705705885608;14947.177905215318;15161.209697575607;15945.760813588038;13505.594832155051;13710.725785484434;13796.172229666252;13983.860161398256;14041.034255204484;13316.733665326832;13533.390997405337;14102.858971410566;14261.144331340152;14574.635634109232;12443.502259909503;13037.934810325887;13512.391942362421;13758.793618095937;13865.514706985206;9315.6273749052;11427.942860285646;11636.476358564054;11976.443062401831;11988.64034078979;9530.523473826419;10053.69838904834;10255.33340332876;10937;10974.615888443866 09:19:32 INFO - PROCESS | 2003 | __end_tp_report 09:19:32 INFO - PROCESS | 2003 | __start_cc_report 09:19:32 INFO - PROCESS | 2003 | _x_x_mozilla_cycle_collect,371 09:19:32 INFO - PROCESS | 2003 | __end_cc_report 09:19:32 INFO - PROCESS | 2003 | __startTimestamp1474301972150__endTimestamp 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | ------- Summary: start ------- 09:19:32 INFO - PROCESS | 2003 | Number of tests: 6 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | [#0] dojo.html Cycles:165 Average:5947.24 Median:6188.72 stddev:652.11 (10.5%) stddev-sans-first:624.45 09:19:32 INFO - PROCESS | 2003 | Values: 3468.6 3479.9 3500.8 3513.6 3537.3 6001.5 6040.8 6074.5 6091.8 6125.6 6026.8 6087.2 6089.5 6101.6 6136.0 5408.7 5451.5 5454.8 5524.1 5547.3 5502.1 5515.7 5520.4 5528.8 5600.7 5360.4 5370.2 5420.0 5516.7 5530.8 5439.4 5458.4 5474.9 5480.2 5503.3 5298.8 5442.1 5464.7 5471.8 5492.9 5879.6 5894.1 6015.3 6117.9 6153.6 6317.1 6328.8 6367.5 6386.9 6390.9 6484.4 6502.3 6507.1 6526.2 6539.9 5936.3 6003.0 6049.2 6123.5 6181.7 6533.5 6543.5 6544.0 6566.0 6580.1 6305.7 6306.0 6315.7 6317.9 6318.2 6174.7 6246.3 6272.8 6421.1 6430.8 6243.6 6277.8 6317.0 6318.4 6347.7 6302.2 6320.0 6324.5 6328.1 6337.7 4904.9 4917.9 5041.2 5061.3 5118.7 4202.5 4516.3 4524.0 4542.6 4590.1 6046.9 6126.7 6159.9 6188.7 6212.7 6219.7 6310.5 6447.9 6490.2 6672.0 6111.3 6143.0 6149.5 6156.9 6158.5 5573.0 5577.0 5592.7 5594.5 5617.7 5536.8 6371.6 6434.8 6574.1 6619.2 6287.7 6322.7 6396.2 6476.6 6494.6 6535.8 6598.7 6622.6 6623.3 6625.7 6205.8 6289.7 6342.8 6345.7 6345.8 5207.7 6209.9 6281.4 6282.3 6320.6 6288.5 6293.7 6299.0 6302.8 6308.4 6181.9 6257.0 6271.6 6288.9 6291.7 6061.9 6103.8 6111.0 6115.9 6201.5 6267.1 6300.6 6302.2 6316.6 6334.4 5295.6 6212.2 6267.3 6271.8 6275.1 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | [#1] ext.html Cycles:180 Average:71394.61 Median:21980.74 stddev:163076.24 (741.9%) stddev-sans-first:163446.81 09:19:32 INFO - PROCESS | 2003 | Values: 486.5 497.1 514.5 523.7 542.9 38612.6 40420.2 40525.0 40693.2 40694.6 41398.8 41842.6 41866.8 41987.2 42110.0 9758.0 9828.2 9830.5 9830.8 9846.2 8347.2 9746.5 9788.7 9800.9 9810.7 9746.5 9782.6 9786.8 9794.0 9818.1 9737.8 9770.8 9785.7 9808.5 9814.3 9755.7 9807.9 9839.8 9844.9 9846.5 39541.0 39887.4 39904.0 39937.8 39966.2 3394.9 3539.8 3553.8 3995.3 4093.3 29824.4 30393.7 30489.0 30573.7 30863.5 3239.6 3286.3 3299.7 3299.7 3305.6 497578.0 506489.5 507693.0 508089.0 512242.0 33115.0 34088.1 58355.1 58642.7 58803.4 31582.8 33949.8 34214.8 34369.0 34458.8 15064.8 15133.9 15272.4 15281.5 15289.7 9490.9 11495.4 12666.1 12873.4 13071.9 7579.3 7703.0 7739.8 7767.5 7797.6 3202.7 3251.5 3251.8 3259.4 3279.1 928.3 950.5 958.4 960.9 1059.0 30040.4 30340.9 30410.5 30660.4 31784.4 900.6 1060.4 1073.5 1079.2 1093.2 14145.5 15359.5 15493.5 15547.8 15814.9 692778.0 701082.0 701181.0 702594.0 704702.0 56329.9 56636.0 56723.9 56807.4 56882.7 1345.8 1366.4 1387.1 1387.7 1393.1 24378.6 28947.9 29115.1 29741.7 30332.8 49024.5 49300.5 49431.8 49554.0 49654.8 599167.0 599372.0 600412.0 602363.0 603158.0 26520.7 26569.7 26915.2 26941.0 26994.6 43728.6 43844.3 43907.0 46105.3 47417.5 38770.6 38817.6 39784.0 40451.4 40600.8 39017.0 39364.2 39506.0 40564.6 40616.8 37878.8 37880.6 38322.0 38445.6 38634.6 32668.7 33173.3 34461.8 35060.0 35126.8 25791.4 25849.4 25855.4 26160.9 26296.5 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | [#2] jquery.html Cycles:180 Average:35480.24 Median:380.23 stddev:104763.22 (27552.4%) stddev-sans-first:105023.93 09:19:32 INFO - PROCESS | 2003 | Values: 367.6 377.3 383.1 383.3 397.8 16012.0 19998.1 20853.4 20872.6 21126.7 11565.2 11671.9 11999.5 12011.6 12033.8 4209.3 4734.5 5248.5 5557.2 5563.5 3931.4 4123.5 5479.5 5870.0 6135.4 6211.0 6213.3 6213.8 6225.5 6225.7 5163.4 5408.6 6009.6 6225.9 6239.4 5367.9 5748.1 6041.8 6047.2 6069.0 13060.9 13133.0 13235.0 13286.5 13306.7 2297.4 2363.6 2363.7 2421.1 2469.2 9731.8 9870.7 9898.1 10319.3 10391.8 1727.5 1805.0 1823.2 1880.0 1933.4 118437.8 120824.4 122250.0 122782.0 124091.0 11537.7 11678.3 11788.2 11834.9 11846.2 14681.3 14767.3 14784.7 14804.9 14860.6 6989.7 8622.7 8773.2 8807.4 8890.4 7337.0 8697.5 8742.4 8810.2 8900.6 3728.5 4537.9 4608.0 4632.4 4687.6 1588.2 1690.4 1696.5 1888.7 1997.4 855.3 889.3 918.6 990.0 1017.8 17163.0 21074.8 21339.5 21447.2 21462.0 894.1 921.8 934.2 953.8 989.9 10942.5 11174.5 11260.2 11271.6 11398.0 619754.0 623264.0 627536.0 628668.0 630465.0 133122.0 136004.0 140095.0 140718.0 140997.0 907.0 917.9 924.0 929.0 953.4 15282.9 17557.6 17878.1 19256.2 19451.6 51525.5 51609.5 52445.5 53511.7 55529.0 78322.0 79032.6 81363.0 84255.0 84414.3 6817.2 7233.6 7493.7 7546.3 7684.2 12471.8 12797.6 13086.1 13332.9 13399.5 10765.2 10865.5 11098.6 11187.8 11502.8 10484.4 10746.8 10791.4 10815.4 10903.1 5108.2 6248.7 8780.5 10550.9 10588.7 7158.9 7350.6 7425.9 7459.7 7600.6 8850.7 8907.9 10071.3 10098.7 10399.7 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | [#3] mootools.html Cycles:180 Average:5759.57 Median:4957.36 stddev:3225.75 (65.1%) stddev-sans-first:3219.09 09:19:32 INFO - PROCESS | 2003 | Values: 1523.6 1547.2 1769.5 1788.1 1868.7 7506.6 8186.9 8441.5 9197.3 9220.9 8278.2 8602.1 8692.0 9016.5 9036.6 2367.0 2398.8 2404.9 2410.7 2413.6 2369.3 2392.4 2412.8 2413.1 2415.6 2032.5 2277.7 2395.3 2400.3 2408.8 2356.9 2376.9 2383.0 2397.4 2400.8 2353.1 2354.7 2364.9 2367.6 2381.6 9004.0 9024.5 9050.6 9054.1 9078.0 5284.3 5349.7 5416.8 5423.2 5437.1 3398.2 3425.2 3459.4 3521.4 3566.9 1091.5 1094.2 1105.3 1111.5 1114.5 11773.9 11860.0 11899.9 11913.6 11920.8 4551.3 4616.5 4766.0 4780.8 4817.1 8585.0 9218.5 10004.7 10084.3 10090.4 5369.7 5380.8 5382.2 5383.2 5391.3 4455.6 4579.1 4790.8 4848.8 4935.4 3920.5 3949.2 4020.0 4038.5 4049.5 1225.7 1302.5 1314.4 1328.3 1347.6 767.8 894.5 904.0 925.1 933.8 6013.9 6047.4 6081.2 6088.8 6351.1 886.4 890.1 903.8 926.7 957.5 3915.2 3996.4 4027.3 4046.5 4092.5 10576.1 11045.7 11052.4 11058.7 11071.3 9302.4 10904.4 11015.0 11033.7 11054.2 7053.4 8277.8 8357.5 8406.4 8455.2 4920.5 5758.3 5928.6 6071.9 6080.0 8808.9 9280.9 10256.5 10312.3 10321.3 9465.5 10439.7 10456.7 10539.8 10601.5 7113.6 7354.8 7398.0 7669.7 7836.0 8342.8 8585.0 8596.3 8598.0 8600.1 7532.7 7656.6 7681.3 7780.8 7788.2 7399.6 7509.5 7534.6 7535.2 7625.2 6967.4 7142.0 7145.7 7152.3 7180.6 4460.7 4979.4 5087.6 5094.9 5141.3 5137.7 5148.1 5152.3 5190.5 5215.7 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | [#4] prototype.html Cycles:180 Average:4714.37 Median:5280.43 stddev:1485.95 (28.1%) stddev-sans-first:1452.82 09:19:32 INFO - PROCESS | 2003 | Values: 306.7 310.3 318.1 321.1 321.5 5124.6 5439.3 5640.3 5728.2 5755.5 4675.8 4693.7 5433.8 5550.3 5587.9 3575.4 3726.3 4244.2 4265.9 4268.0 3323.7 4033.4 4270.1 4273.8 4281.6 3672.6 4207.2 4211.9 4227.8 4267.8 4208.8 4227.5 4241.4 4258.7 4260.6 3240.4 3476.1 3651.9 3674.3 3699.0 4544.8 5298.4 5393.5 5418.3 5469.3 4070.5 4189.2 4734.5 4907.0 4931.0 4886.0 5108.6 5922.3 5953.8 5965.1 3357.8 3879.7 3935.4 4074.9 4101.6 5084.9 5550.3 6208.8 6221.9 6222.7 3396.6 3570.6 3975.4 4122.6 4130.9 3128.5 4005.0 4098.6 4177.9 4222.6 4546.1 4627.9 4892.0 4895.0 4927.4 4702.7 5173.5 5933.6 5952.4 5971.6 1350.8 1411.9 1427.6 1431.6 1445.5 931.9 947.0 958.3 959.6 975.4 5577.1 5591.5 5592.4 5593.7 5602.6 5253.1 5348.2 6067.4 6093.5 6113.4 5299.6 5524.9 5539.4 5570.8 5580.7 2614.4 2691.4 2709.0 2726.0 2755.0 4642.4 4860.7 5262.4 5318.9 5342.3 5226.9 5562.8 5854.4 6358.7 6418.8 6076.5 6454.2 6479.8 6495.5 6523.6 5134.0 5649.9 5964.6 6163.4 6256.5 5457.7 5594.4 5640.1 6090.7 6161.3 6051.5 6121.4 6405.4 6430.5 6490.4 4013.9 4014.4 4054.6 4064.9 4066.5 5534.6 5664.6 5881.0 6042.5 6160.3 5168.9 5171.3 5817.0 5920.5 6022.9 4804.9 5977.9 6030.8 6036.5 6051.2 5669.2 5831.6 5841.9 5894.0 5908.7 5062.0 5327.5 6007.9 6044.3 6045.9 4834.4 5214.7 5584.3 5879.6 5891.2 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - PROCESS | 2003 | [#5] yui.html Cycles:180 Average:23745.36 Median:3868.44 stddev:37125.58 (959.7%) stddev-sans-first:37189.49 09:19:32 INFO - PROCESS | 2003 | Values: 723.6 764.7 767.9 804.9 826.5 15465.0 15680.6 15920.3 15960.0 16024.3 14236.4 14286.5 14355.1 14360.4 14385.7 816.4 831.2 874.5 878.3 889.8 848.3 854.7 875.1 875.4 883.6 903.4 909.6 912.4 913.4 918.8 887.3 892.4 895.2 901.8 902.4 676.1 677.5 678.4 681.3 682.1 13036.7 13079.4 13112.4 13133.2 13144.6 14128.5 14221.4 14398.1 14567.3 14659.0 11792.9 11894.6 11956.7 11998.6 12447.5 3754.7 3834.5 3848.8 3853.9 3883.0 131304.0 131971.0 134022.7 134575.0 134736.7 9464.4 10950.3 10975.6 11085.9 11097.6 22177.8 22267.6 22271.2 22285.0 22286.1 7586.4 7864.9 8017.5 8033.1 8158.8 4321.8 4393.9 4416.1 4486.3 4527.3 2796.9 3606.5 3606.7 3606.9 3801.2 694.7 708.6 712.0 722.5 723.3 429.6 554.9 656.7 662.0 687.3 8975.9 9422.5 9534.3 9537.6 9589.2 564.3 659.9 674.3 684.5 684.5 4335.5 4547.8 4645.0 4706.0 4710.5 90897.0 91424.0 92041.1 135960.6 153214.0 87007.0 94606.0 112662.3 120509.0 122793.0 104551.0 108105.0 108602.5 110011.0 111354.0 8654.6 9020.7 9065.8 9071.7 9198.7 49079.3 58028.4 62624.0 64366.7 64930.7 76531.0 91488.6 91591.5 93723.1 98421.0 10618.3 12704.9 12816.2 13365.2 13465.4 14467.0 14714.7 14947.2 15161.2 15945.8 13505.6 13710.7 13796.2 13983.9 14041.0 13316.7 13533.4 14102.9 14261.1 14574.6 12443.5 13037.9 13512.4 13758.8 13865.5 9315.6 11427.9 11636.5 11976.4 11988.6 9530.5 10053.7 10255.3 10937.0 10974.6 09:19:32 INFO - PROCESS | 2003 | -------- Summary: end -------- 09:19:32 INFO - PROCESS | 2003 | 09:19:32 INFO - TEST-INFO | 2003: exit 0 09:19:32 INFO - TEST-OK | dromaeo_css | took 1114470ms 09:19:32 INFO - TEST-START | kraken 09:19:32 INFO - operating with platform_type : mac_ 09:19:32 INFO - Initialising browser for kraken test... 09:19:32 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmppesBnw/profile http://localhost:49391/getInfo.html) 09:19:35 INFO - PROCESS | 2010 | __metrics Screen width/height:1600/1200 09:19:35 INFO - PROCESS | 2010 | colorDepth:24 09:19:35 INFO - PROCESS | 2010 | Browser inner width/height: 1024/689 09:19:35 INFO - PROCESS | 2010 | __metrics 09:19:35 ERROR - PROCESS | 2010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 09:19:36 INFO - TEST-INFO | 2010: exit 0 09:19:36 INFO - Browser initialized. 09:19:36 INFO - Running cycle 1/1 for kraken test... 09:19:36 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmppesBnw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:48 INFO - PROCESS | 2012 | RSS: Main: 224493568 09:19:48 INFO - PROCESS | 2012 | 09:19:51 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:52 INFO - PROCESS | 2012 | RSS: Main: 237187072 09:19:52 INFO - PROCESS | 2012 | 09:19:55 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-dft) 09:19:55 INFO - PROCESS | 2012 | RSS: Main: 244834304 09:19:55 INFO - PROCESS | 2012 | 09:19:59 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-fft) 09:20:00 INFO - PROCESS | 2012 | RSS: Main: 246640640 09:20:00 INFO - PROCESS | 2012 | 09:20:02 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator) 09:20:02 INFO - PROCESS | 2012 | RSS: Main: 249319424 09:20:02 INFO - PROCESS | 2012 | 09:20:04 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:20:05 INFO - PROCESS | 2012 | RSS: Main: 249839616 09:20:05 INFO - PROCESS | 2012 | 09:20:08 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom) 09:20:08 INFO - PROCESS | 2012 | RSS: Main: 250814464 09:20:08 INFO - PROCESS | 2012 | 09:20:11 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate) 09:20:12 INFO - PROCESS | 2012 | RSS: Main: 250920960 09:20:12 INFO - PROCESS | 2012 | 09:20:15 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial) 09:20:16 INFO - PROCESS | 2012 | RSS: Main: 251277312 09:20:16 INFO - PROCESS | 2012 | 09:20:17 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:20:18 INFO - PROCESS | 2012 | RSS: Main: 250978304 09:20:18 INFO - PROCESS | 2012 | 09:20:20 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:20:20 INFO - PROCESS | 2012 | RSS: Main: 251092992 09:20:20 INFO - PROCESS | 2012 | 09:20:22 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:23 INFO - PROCESS | 2012 | RSS: Main: 251113472 09:20:23 INFO - PROCESS | 2012 | 09:20:26 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:27 INFO - PROCESS | 2012 | RSS: Main: 251383808 09:20:27 INFO - PROCESS | 2012 | 09:20:30 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:31 INFO - PROCESS | 2012 | RSS: Main: 251334656 09:20:31 INFO - PROCESS | 2012 | 09:20:32 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49391/tests/kraken/driver.html?testName=ai-astar) 09:20:33 INFO - PROCESS | 2012 | RSS: Main: 252944384 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | __start_tp_report 09:20:33 INFO - PROCESS | 2012 | _x_x_mozilla_page_load 09:20:33 INFO - PROCESS | 2012 | _x_x_mozilla_page_load_details 09:20:33 INFO - PROCESS | 2012 | |i|pagename|runs| 09:20:33 INFO - PROCESS | 2012 | |0;ai-astar;107;125;117;129;120;120;119;120;120;119 09:20:33 INFO - PROCESS | 2012 | |1;audio-beat-detection;147;126;113;143;110;112;141;144;137;118 09:20:33 INFO - PROCESS | 2012 | |2;audio-dft;217;217;181;174;256;286;263;204;191;199 09:20:33 INFO - PROCESS | 2012 | |3;audio-fft;84;62;54;78;61;70;90;81;100;83 09:20:33 INFO - PROCESS | 2012 | |4;audio-oscillator;87;58;100;105;102;104;106;70;68;88 09:20:33 INFO - PROCESS | 2012 | |5;imaging-gaussian-blur;90;132;115;85;94;85;89;93;88;86 09:20:33 INFO - PROCESS | 2012 | |6;imaging-darkroom;95;96;95;95;95;95;95;107;94;94 09:20:33 INFO - PROCESS | 2012 | |7;imaging-desaturate;105;93;147;150;91;75;149;146;91;92 09:20:33 INFO - PROCESS | 2012 | |8;json-parse-financial;58;55;56;56;58;59;58;59;59;58 09:20:33 INFO - PROCESS | 2012 | |9;json-stringify-tinderbox;67;69;76;77;73;69;70;71;72;70 09:20:33 INFO - PROCESS | 2012 | |10;stanford-crypto-aes;84;88;85;89;87;82;85;95;106;108 09:20:33 INFO - PROCESS | 2012 | |11;stanford-crypto-ccm;140;143;138;157;142;143;146;169;196;141 09:20:33 INFO - PROCESS | 2012 | |12;stanford-crypto-pbkdf2;204;170;248;246;192;173;173;200;252;226 09:20:33 INFO - PROCESS | 2012 | |13;stanford-crypto-sha256-iterative;71;70;69;69;72;70;72;91;70;69 09:20:33 INFO - PROCESS | 2012 | __end_tp_report 09:20:33 INFO - PROCESS | 2012 | __start_cc_report 09:20:33 INFO - PROCESS | 2012 | _x_x_mozilla_cycle_collect,954 09:20:33 INFO - PROCESS | 2012 | __end_cc_report 09:20:33 INFO - PROCESS | 2012 | __startTimestamp1474302033172__endTimestamp 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | ------- Summary: start ------- 09:20:33 INFO - PROCESS | 2012 | Number of tests: 14 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#0] ai-astar Cycles:10 Average:119.60 Median:120.00 stddev:5.62 (4.7%) stddev-sans-first:3.67 09:20:33 INFO - PROCESS | 2012 | Values: 107.0 125.0 117.0 129.0 120.0 120.0 119.0 120.0 120.0 119.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:139.00 stddev:14.87 (10.7%) stddev-sans-first:14.29 09:20:33 INFO - PROCESS | 2012 | Values: 147.0 126.0 113.0 143.0 110.0 112.0 141.0 144.0 137.0 118.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#2] audio-dft Cycles:10 Average:218.80 Median:217.00 stddev:37.53 (17.3%) stddev-sans-first:39.81 09:20:33 INFO - PROCESS | 2012 | Values: 217.0 217.0 181.0 174.0 256.0 286.0 263.0 204.0 191.0 199.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#3] audio-fft Cycles:10 Average:76.30 Median:79.50 stddev:14.35 (18.1%) stddev-sans-first:14.95 09:20:33 INFO - PROCESS | 2012 | Values: 84.0 62.0 54.0 78.0 61.0 70.0 90.0 81.0 100.0 83.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:63.00 stddev:17.73 (28.1%) stddev-sans-first:18.79 09:20:33 INFO - PROCESS | 2012 | Values: 87.0 58.0 100.0 105.0 102.0 104.0 106.0 70.0 68.0 88.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:88.50 stddev:15.49 (17.5%) stddev-sans-first:16.29 09:20:33 INFO - PROCESS | 2012 | Values: 90.0 132.0 115.0 85.0 94.0 85.0 89.0 93.0 88.0 86.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:95.00 stddev:3.87 (4.1%) stddev-sans-first:4.09 09:20:33 INFO - PROCESS | 2012 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 107.0 94.0 94.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#7] imaging-desaturate Cycles:10 Average:113.90 Median:83.00 stddev:30.22 (36.4%) stddev-sans-first:31.88 09:20:33 INFO - PROCESS | 2012 | Values: 105.0 93.0 147.0 150.0 91.0 75.0 149.0 146.0 91.0 92.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.43 (2.5%) stddev-sans-first:1.51 09:20:33 INFO - PROCESS | 2012 | Values: 58.0 55.0 56.0 56.0 58.0 59.0 58.0 59.0 59.0 58.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:3.17 (4.4%) stddev-sans-first:2.93 09:20:33 INFO - PROCESS | 2012 | Values: 67.0 69.0 76.0 77.0 73.0 69.0 70.0 71.0 72.0 70.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:86.00 stddev:9.19 (10.7%) stddev-sans-first:9.41 09:20:33 INFO - PROCESS | 2012 | Values: 84.0 88.0 85.0 89.0 87.0 82.0 85.0 95.0 106.0 108.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:144.50 stddev:18.28 (12.6%) stddev-sans-first:18.91 09:20:33 INFO - PROCESS | 2012 | Values: 140.0 143.0 138.0 157.0 142.0 143.0 146.0 169.0 196.0 141.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:208.40 Median:215.00 stddev:32.54 (15.1%) stddev-sans-first:34.48 09:20:33 INFO - PROCESS | 2012 | Values: 204.0 170.0 248.0 246.0 192.0 173.0 173.0 200.0 252.0 226.0 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - PROCESS | 2012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:70.50 stddev:6.67 (9.5%) stddev-sans-first:7.06 09:20:33 INFO - PROCESS | 2012 | Values: 71.0 70.0 69.0 69.0 72.0 70.0 72.0 91.0 70.0 69.0 09:20:33 INFO - PROCESS | 2012 | -------- Summary: end -------- 09:20:33 INFO - PROCESS | 2012 | 09:20:33 INFO - TEST-INFO | 2012: exit 0 09:20:34 INFO - TEST-OK | kraken | took 61217ms 09:20:34 INFO - SUITE-END | took 1175s 09:20:34 INFO - Completed test suite (00:19:36) 09:20:34 INFO - javascript benchmark 09:20:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7310.012715510256, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3468.6184519702833, 3479.9304013919723, 3500.7549471536995, 3513.6135025147214, 3537.292541491701, 6001.459868611824, 6040.758369665208, 6074.453299203076, 6091.78678746244, 6125.5712100153005, 6026.819195424133, 6087.20866287382, 6089.45194932456, 6101.572889897709, 6136.0, 5408.675479471234, 5451.536619387357, 5454.754536045868, 5524.06090964537, 5547.306586676666, 5502.119660854264, 5515.669059856401, 5520.447955204488, 5528.806491772789, 5600.747966341524, 5360.437154098822, 5370.248165256867, 5419.972900135494, 5516.724163791794, 5530.806421775239, 5439.428859969706, 5458.399576046631, 5474.863128421782, 5480.177973303997, 5503.257060296849, 5298.761555729963, 5442.102053161224, 5464.6994415307145, 5471.808486702986, 5492.917606235909, 5879.647221166743, 5894.115882617599, 6015.3383127855905, 6117.877642447126, 6153.630782153085, 6317.1156038154695, 6328.778492752777, 6367.522435817332, 6386.8722625547225, 6390.872182556369, 6484.351564843525, 6502.252240992299, 6507.089007538948, 6526.249481309663, 6539.901901471481, 5936.347001829795, 6002.969985150134, 6049.153118563405, 6123.510119190454, 6181.6600086995195, 6533.542652014314, 6543.5419520633095, 6543.967280163664, 6566.0, 6580.11168492257, 6305.684715764193, 6305.968470157712, 6315.684215789192, 6317.905231421532, 6318.210223722035, 6174.691265436711, 6246.3441338659695, 6272.843178920563, 6421.068945002949, 6430.7749228776765, 6243.562950593415, 6277.811665650038, 6317.0, 6318.399752023551, 6347.714352854133, 6302.212223472066, 6319.968400158062, 6324.494040476751, 6328.145700330489, 6337.683115844189, 4904.926426103611, 4917.877053073702, 5041.21861111521, 5061.266116413173, 5118.667286626357, 4202.495700515897, 4516.299973504112, 4523.977380113144, 4542.636589072867, 4590.1278757036725, 6046.939530604637, 6126.663033533109, 6159.876802463926, 6188.721507532172, 6212.658303793244, 6219.720112594944, 6310.495160387158, 6447.903281450782, 6490.188726409199, 6672.032555279555, 6111.327753947062, 6142.9864072428445, 6149.538784591084, 6156.8917594832465, 6158.538109641795, 5573.0, 5576.972115139399, 5592.748326325325, 5594.524465420485, 5617.747201375948, 5536.75084621193, 6371.553991220755, 6434.839129021625, 6574.079628851869, 6619.172603424572, 6287.748490060347, 6322.652254125883, 6396.168498095218, 6476.6114033158165, 6494.642794646151, 6535.803925882231, 6598.736050557924, 6622.602643841385, 6623.304553021863, 6625.701843417154, 6205.782797602063, 6289.7169627365965, 6342.7780027700655, 6345.7144428499905, 6345.777897773556, 5207.71357575337, 6209.937900620936, 6281.434670879643, 6282.277538083179, 6320.62076275425, 6288.496920246461, 6293.653849038347, 6298.968505157445, 6302.779402720883, 6308.369163083655, 6181.907271390843, 6257.0, 6271.62370257786, 6288.937110628835, 6291.716872740829, 6061.878762424815, 6103.847403814762, 6110.953680641605, 6115.909724157069, 6201.472874805692, 6267.059941008885, 6300.621962682254, 6302.212223472066, 6316.557840951089, 6334.429901308904, 5295.602829787705, 6212.192414986023, 6267.341929097562, 6271.811845644638, 6275.121482992294], "value": 5906.077124442083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.46488862251505, 497.08536293220465, 514.4598171919483, 523.6568202560435, 542.946683434138, 38612.61387386125, 40420.19159616806, 40525.0, 40693.186136277334, 40694.59305406945, 41398.793006034924, 41842.58157418425, 41866.790666046625, 41987.16025679484, 42110.0, 9757.975412581683, 9828.213742900587, 9830.459324737136, 9830.803383932318, 9846.1630761385, 8347.248747612713, 9746.512674366253, 9788.706338809847, 9800.90199098007, 9810.656627018056, 9746.46394448305, 9782.608695652165, 9786.755331116708, 9794.0, 9818.067283608081, 9737.756556086084, 9770.804583908353, 9785.706428807147, 9808.46053467059, 9814.312998090136, 9755.707328780149, 9807.90192098077, 9839.803203935953, 9844.852327215098, 9846.458444785534, 39541.01147471307, 39887.4016889744, 39904.00239993994, 39937.80186594378, 39966.200675986605, 3394.8642054317797, 3539.80531070791, 3553.751237413382, 3995.2808494471274, 4093.3450647896193, 29824.403511929857, 30393.696063039308, 30489.0, 30573.694263057307, 30863.53704694409, 3239.5626590410466, 3286.260591366947, 3299.6700329967052, 3299.736021118305, 3305.5702758641223, 497578.0, 506489.4675526636, 507693.0, 508089.0, 512242.0, 33115.00654980355, 34088.14779630529, 58355.12467312994, 58642.706786465795, 58803.41196588065, 31582.842085789423, 33949.83025084859, 34214.82892585521, 34369.0, 34458.82770586181, 15064.774028389584, 15133.924330378497, 15272.38910443592, 15281.46514871974, 15289.694206115815, 9490.90509094914, 11495.42522873853, 12666.113372063866, 12873.420696068511, 13071.869281307256, 7579.317861392501, 7703.0, 7739.845203096019, 7767.495112817649, 7797.571133587707, 3202.711755941976, 3251.512273159045, 3251.8048917065053, 3259.445894197992, 3279.1474216703828, 928.2898582584328, 950.4867371619387, 958.3722661656626, 960.8750862387984, 1058.957641694339, 30040.399192016037, 30340.938067167986, 30410.47947602611, 30660.38679226403, 31784.364312713617, 900.5542256583034, 1060.3690803971624, 1073.457903758597, 1079.2499213046858, 1093.169191414515, 14145.504907328193, 15359.462418815288, 15493.535193944199, 15547.833912456612, 15814.920925395529, 692778.0, 701082.0, 701181.0, 702594.0, 704702.0, 56329.87340253172, 56636.0, 56723.86552268932, 56807.43192568104, 56882.71558642263, 1345.757763602561, 1366.3987845348015, 1387.084524214014, 1387.7293927684207, 1393.0736060519641, 24378.634320485562, 28947.855260724406, 29115.126546203646, 29741.702582974758, 30332.786688533095, 49024.50975490342, 49300.50699493103, 49431.75284123556, 49554.0, 49654.751726241135, 599167.0, 599372.0, 600412.0, 602363.0, 603158.0, 26520.734792651827, 26569.734302656725, 26915.192544223704, 26941.0, 26994.595081073407, 43728.56271437372, 43844.34233486564, 43907.0, 46105.30842037439, 47417.52582474131, 38770.61229387783, 38817.6118238814, 39784.0, 40451.39322910218, 40600.79699601483, 39017.0, 39364.2127157461, 39506.0, 40564.594354056084, 40616.79691601523, 37878.8106059468, 37880.62119378771, 38322.0, 38445.6155438442, 38634.6136538631, 32668.67331326656, 33173.33653326872, 34461.79383721558, 35060.0, 35126.824365878005, 25791.355216119748, 25849.353766155997, 25855.353616159748, 26160.86919565466, 26296.4740705181], "value": 18689.541074647033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.63604032008317, 377.3208225194649, 383.1436738888582, 383.2679581998383, 397.7633308181633, 16011.999999999985, 19998.10008549615, 20853.37439876806, 20872.582548349063, 21126.683099753478, 11565.248258863168, 11671.883281167185, 11999.460024298905, 12011.579594714187, 12033.75932481352, 4209.305464598346, 4734.502877197896, 5248.501392367719, 5557.166425036236, 5563.471470210344, 3931.351327031051, 4123.546409894909, 5479.4520547945285, 5869.9706501467645, 6135.3557876423, 6211.0372892201785, 6213.285472170691, 6213.844653883644, 6225.533085018619, 6225.719842607071, 5163.406208286039, 5408.648437851527, 6009.617787908805, 6225.937740622627, 6239.438450539428, 5367.892642147174, 5748.137779333092, 6041.848953776147, 6047.213862197887, 6069.028955367165, 13060.934695326463, 13133.0, 13235.00737444686, 13286.534971276056, 13306.73386532264, 2297.425643589103, 2363.5627408929404, 2363.6572696959015, 2421.055788242587, 2469.1851688942784, 9731.805363892683, 9870.703878883573, 9898.10917017472, 10319.277650564463, 10391.79216415675, 1727.5468834255387, 1804.9909750451163, 1823.179569193868, 1879.9508535696157, 1933.3716542123725, 118437.81562184355, 120824.39587802092, 122250.0, 122782.0, 124091.0, 11537.653870383734, 11678.299302041734, 11788.174827761974, 11834.8769410784, 11846.229995050295, 14681.339339729739, 14767.26163691811, 14784.704305913821, 14804.851951480347, 14860.62848428798, 6989.720411183597, 8622.655093796178, 8773.166549177819, 8807.383483156245, 8890.377673562918, 7337.0, 8697.521636310064, 8742.388032837767, 8810.163034511712, 8900.599473023729, 3728.5339332583426, 4537.886552836139, 4607.95392046082, 4632.444106707149, 4687.601553867959, 1588.213834152079, 1690.3914590747322, 1696.5164927995709, 1888.6978083506847, 1997.4307322413042, 855.3029281135854, 889.2530274569393, 918.609590923868, 990.029770824596, 1017.760826205841, 17162.970221786734, 21074.789252107283, 21339.46651333698, 21447.249346272805, 21462.0, 894.1014280647908, 921.7511271956669, 934.1919239857474, 953.7886883657716, 989.9257555683208, 10942.4528773561, 11174.497147628375, 11260.155488338407, 11271.605493807678, 11398.0, 619754.0, 623264.0, 627536.0, 628668.0, 630465.0, 133122.0, 136004.0, 140095.0, 140718.0, 140997.0, 907.0385391485047, 917.9173874351206, 923.9630414783334, 929.0, 953.389830508489, 15282.923585382003, 17557.648847023243, 17878.106094695475, 19256.22975080981, 19451.61096778085, 51525.48474515207, 51609.48390516197, 52445.47554524559, 53511.732441337546, 55529.0, 78322.0, 79032.60483697544, 81363.0, 84255.0, 84414.31171376661, 6817.216020157745, 7233.602151881487, 7493.662785174789, 7546.320831125225, 7684.1547429783795, 12471.812922806346, 12797.616071517497, 13086.0839741221, 13332.866671333162, 13399.53101641438, 10765.246432749946, 10865.511052002521, 11098.5560577576, 11187.832182517106, 11502.769944600894, 10484.423356715453, 10746.785064298514, 10791.40647264408, 10815.35107893529, 10903.073238774792, 5108.157154069537, 6248.68756562161, 8780.463418901794, 10550.947245263724, 10588.682339529827, 7158.854583266652, 7350.632468376667, 7425.925740742739, 7459.738909138154, 7600.619969001638, 8850.73447796567, 8907.910920890708, 10071.295009349275, 10098.697039088838, 10399.740006499898], "value": 9058.285687710972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.6114790728366, 1547.2031903569662, 1769.4868488138432, 1788.0523322639006, 1868.6732419981813, 7506.624668766561, 8186.877196842052, 8441.49351038938, 9197.310201734872, 9220.8616870747, 8278.213569710868, 8602.139786021395, 8691.956540217307, 9016.504092274923, 9036.63853445863, 2367.029517897662, 2398.796102331304, 2404.8917798699013, 2410.7468715784853, 2413.6017557103146, 2369.2655276864143, 2392.3660230039054, 2412.7587241275905, 2413.1312727418117, 2415.6497307890345, 2032.4613977296028, 2277.749447560767, 2395.2933884504027, 2400.255920664591, 2408.8313818032743, 2356.882155892216, 2376.857388556692, 2382.9880850595723, 2397.436602398435, 2400.7959323457526, 2353.0587764894008, 2354.7174339079247, 2364.900321350563, 2367.5501654685554, 2381.618940969454, 9004.00955894851, 9024.548772561411, 9050.592723327467, 9054.094590540959, 9078.046805085436, 5284.339457567804, 5349.732513374354, 5416.783328666848, 5423.2136340230445, 5437.102878025121, 3398.218409765768, 3425.1950791563963, 3459.3600183965796, 3521.4365701487895, 3566.946495802565, 1091.497910960959, 1094.2340361746808, 1105.3312745788842, 1111.5164903267105, 1114.5263263113225, 11773.941130294379, 11859.999999999915, 11899.940500297444, 11913.642590722293, 11920.761584768343, 4551.340055691906, 4616.515265897033, 4766.0, 4780.808767649255, 4817.084753896748, 8585.0, 9218.53907304632, 10004.749881252881, 10084.344517606332, 10090.445025523666, 5369.677819330853, 5380.838574842761, 5382.219578161144, 5383.2194331821665, 5391.272178255886, 4455.576720211575, 4579.107074120515, 4790.808367665254, 4848.806047758121, 4935.358403407606, 3920.4707364506, 3949.249642567903, 4020.035191554006, 4038.495188101487, 4049.53430355507, 1225.662942690767, 1302.4529697527062, 1314.4413624209672, 1328.3092791748236, 1347.5553067487706, 767.7850201943464, 894.4812009034745, 904.0462312260628, 925.121134921827, 933.8179055084329, 6013.939860601426, 6047.425494578008, 6081.17904082952, 6088.817335479854, 6351.110844481776, 886.4415418286438, 890.1454603580506, 903.8056817784208, 926.7080869526078, 957.5499515227832, 3915.2169566086327, 3996.3805610130476, 4027.315356389362, 4046.5346485154582, 4092.5088989320875, 10576.149173894537, 11045.668629941114, 11052.392118433563, 11058.723531911606, 11071.280366776135, 9302.395344302598, 10904.400257985886, 11015.0, 11033.724156896142, 11054.170937179744, 7053.365197132282, 8277.751667449986, 8357.498550087013, 8406.369522285853, 8455.196756308264, 4920.507949205051, 5758.3090029196765, 5928.614640048383, 6071.939280607137, 6080.0, 8808.867866981873, 9280.907190928005, 10256.53845576936, 10312.27814053009, 10321.277510574188, 9465.47939863314, 10439.739006524898, 10456.738581535523, 10539.78920421572, 10601.46992650349, 7113.612845495079, 7354.77935661931, 7398.038255027027, 7669.7315593953945, 7835.960820195863, 8342.79143021405, 8584.957075214834, 8596.312295016258, 8598.011228708778, 8600.053994060523, 7532.661030253761, 7656.5788881609815, 7681.270279323456, 7780.805479863048, 7788.221177882167, 7399.59302238382, 7509.474336796372, 7534.623268836426, 7535.171131175457, 7625.199354067743, 6967.372936435745, 7142.035825163536, 7145.749898753519, 7152.284771522806, 7180.640967951686, 4460.710053846489, 4979.3526841510375, 5087.567556757569, 5094.923576146435, 5141.331626888481, 5137.743112844418, 5148.073346797612, 5152.30443890085, 5190.480951904779, 5215.687058776485], "value": 4630.830833577439, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.72088399556395, 310.2956289223462, 318.10136364769534, 321.0897106702498, 321.48883275591805, 5124.564412024983, 5439.347278326596, 5640.266765320508, 5728.169415434764, 5755.482006619409, 4675.8363457279, 4693.671442998992, 5433.782648694058, 5550.306211723535, 5587.888242235153, 3575.410057340536, 3726.31063253299, 4244.1511697660435, 4265.936010959838, 4268.0, 3323.667633236669, 4033.4353190553347, 4270.145970805851, 4273.829046838123, 4281.550437204095, 3672.5592928848578, 4207.15856828634, 4211.915761684764, 4227.767472789011, 4267.807948642303, 4208.789560521977, 4227.471566054228, 4241.36379543068, 4258.68059895509, 4260.595243451867, 3240.4329242382487, 3476.148343655795, 3651.8539258429632, 3674.2651469705897, 3698.9630103698887, 4544.840930567414, 5298.443663415363, 5393.487618676219, 5418.322709661293, 5469.343678758534, 4070.4911886014247, 4189.162167566499, 4734.455537613184, 4907.018596280723, 4930.950690493085, 4886.045581767286, 5108.64239503235, 5922.3485416604135, 5953.761849526014, 5965.105234214902, 3357.798532088058, 3879.709021823346, 3935.390014547721, 4074.8777536673947, 4101.630853223194, 5084.949150508522, 5550.27846379968, 6208.820324138399, 6221.9377806222265, 6222.657753823583, 3396.6433524479576, 3570.643155600907, 3975.4495746658827, 4122.649574786117, 4130.855420060344, 3128.530720391959, 4005.0, 4098.631123198927, 4177.874663760092, 4222.619964203236, 4546.090781843644, 4627.8611641650805, 4892.0, 4894.951050489521, 4927.408710954708, 4702.694324868872, 5173.482651734872, 5933.554983376178, 5952.363100147408, 5971.552133589998, 1350.7568637645318, 1411.9152850828777, 1427.6074079628186, 1431.6134643646158, 1445.4507287230786, 931.8788557487484, 947.0311977472967, 958.3148049144755, 959.5538074795254, 975.4439969217478, 5577.107662773937, 5591.505309181762, 5592.356878958891, 5593.720313984284, 5602.635828671123, 5253.133233016586, 5348.171033489815, 6067.362926892701, 6093.451589356979, 6113.358097399798, 5299.6025298102795, 5524.917126243109, 5539.390667026624, 5570.777168913279, 5580.748866301026, 2614.3856193794445, 2691.371720109345, 2708.9864550677516, 2726.0, 2754.9586756198673, 4642.442906851199, 4860.708357498562, 5262.421133675292, 5318.9202161967605, 5342.305500284938, 5226.850092979538, 5562.805301814417, 5854.360778981892, 6358.650274234961, 6418.839529011812, 6076.453119219292, 6454.225492940971, 6479.838004049937, 6495.512836537184, 6523.64119973406, 5133.974330128475, 5649.858753531194, 5964.642121472725, 6163.445289923929, 6256.529715516759, 5457.7271136443815, 5594.356648985418, 5640.125780504029, 6090.665013424127, 6161.291451483136, 6051.5461340400525, 6121.357257488078, 6405.423511883952, 6430.549861509837, 6490.448311893542, 4013.9162426144194, 4014.3777714454304, 4054.594540545922, 4064.898377540585, 4066.53234877981, 5534.640248383842, 5664.581626331468, 5880.970595147168, 6042.546808989256, 6160.291566469913, 5168.914527949022, 5171.3277273954145, 5817.0, 5920.467157955804, 6022.909656355246, 4804.918893249131, 5977.9103313451205, 6030.758769649165, 6036.517078633787, 6051.213342265477, 5669.234653321749, 5831.617661756256, 5841.932985182813, 5894.0274854650215, 5908.734106965283, 5062.0, 5327.493888080626, 6007.897235967376, 6044.33512313654, 6045.939540604538, 4834.395700537433, 5214.661047031931, 5584.329880414376, 5879.618289701831, 5891.203183029217], "value": 4246.2918340933875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.558629236166, 764.7017663111387, 767.8656235158846, 804.9235322644347, 826.495837539101, 15465.0, 15680.607984800386, 15920.283587238573, 15960.04239745616, 16024.278907449163, 14236.430542778277, 14286.499972500964, 14355.06692065015, 14360.425582976668, 14385.712285754278, 816.4121832280763, 831.2311112221201, 874.5190145420025, 878.3193025405299, 889.8175873945826, 848.3086284677998, 854.7179430787857, 875.0767939823484, 875.3741075131312, 883.575883575884, 903.4218100415707, 909.5952301225957, 912.393258483108, 913.4427998920686, 918.8101408675781, 887.2901678657081, 892.384254864145, 895.1853813030111, 901.8016036471965, 902.4269588811119, 676.067027502049, 677.4952660268132, 678.3860606151392, 681.2778454837838, 682.1166589266911, 13036.674083147902, 13079.41142648583, 13112.409941552653, 13133.212007279593, 13144.605661830064, 14128.50550230737, 14221.360038798279, 14398.064125831892, 14567.271636418243, 14659.0, 11792.914660219367, 11894.643160705193, 11956.701082473008, 11998.58004969822, 12447.502099915993, 3754.699624030071, 3834.5015148030857, 3848.826802793881, 3853.903652408684, 3882.9805850970565, 131304.0, 131971.0, 134022.659773402, 134575.0, 134736.6526334734, 9464.432134071978, 10950.3429794211, 10975.615853445091, 11085.889141108648, 11097.611583594535, 22177.778222217894, 22267.55464890693, 22271.22050728249, 22285.0, 22286.108555657593, 7586.431017673696, 7864.882026769603, 8017.518948863087, 8033.1163572007035, 8158.755237342889, 4321.805518751664, 4393.868183954486, 4416.138852923713, 4486.282194848808, 4527.320901864747, 2796.9160925172278, 3606.5311509503595, 3606.711463082947, 3606.9278614427562, 3801.201747633028, 694.7151667816272, 708.624429052603, 711.9572825630479, 722.5411863466736, 723.3381455967835, 429.63695677152754, 554.8834744703577, 656.7143292667705, 661.9834504137435, 687.2817905288985, 8975.910240897507, 9422.481763503074, 9534.28492863038, 9537.61849526025, 9589.184919281939, 564.2777245126163, 659.9010148477671, 674.3020973292619, 684.4558575932047, 684.4592771710293, 4335.458067741532, 4547.840825571089, 4645.007939757742, 4705.976470117696, 4710.52894710533, 90897.0, 91424.0, 92041.07958920459, 135960.64039359678, 153214.0, 87007.0, 94606.0, 112662.31006534908, 120509.0, 122793.0, 104551.0, 108105.0, 108602.45698771614, 110011.0, 111354.0, 8654.567271636268, 9020.684276050306, 9065.77335566616, 9071.727848164566, 9198.724038278862, 49079.26381104215, 58028.4197158023, 62624.0, 64366.67816661074, 64930.675346622964, 76531.0, 91488.62767058366, 91591.54204228937, 93723.06276937143, 98421.0, 10618.309809862334, 12704.936475317565, 12816.166949148275, 13365.198088114745, 13465.394057267642, 14467.0, 14714.705705885608, 14947.177905215318, 15161.209697575607, 15945.760813588038, 13505.594832155051, 13710.725785484434, 13796.172229666252, 13983.860161398256, 14041.034255204484, 13316.733665326832, 13533.390997405337, 14102.858971410566, 14261.144331340152, 14574.635634109232, 12443.502259909503, 13037.934810325887, 13512.391942362421, 13758.793618095937, 13865.514706985206, 9315.6273749052, 11427.942860285646, 11636.476358564054, 11976.443062401831, 11988.64034078979, 9530.523473826419, 10053.69838904834, 10255.33340332876, 10937.0, 10974.615888443866], "value": 7759.897947150397, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 125.0, 117.0, 129.0, 120.0, 120.0, 119.0, 120.0, 120.0, 119.0], "value": 119.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 113.0, 143.0, 110.0, 112.0, 141.0, 144.0, 137.0, 118.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 217.0, 181.0, 174.0, 256.0, 286.0, 263.0, 204.0, 191.0, 199.0], "value": 218.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 62.0, 54.0, 78.0, 61.0, 70.0, 90.0, 81.0, 100.0, 83.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 58.0, 100.0, 105.0, 102.0, 104.0, 106.0, 70.0, 68.0, 88.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 132.0, 115.0, 85.0, 94.0, 85.0, 89.0, 93.0, 88.0, 86.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 107.0, 94.0, 94.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 93.0, 147.0, 150.0, 91.0, 75.0, 149.0, 146.0, 91.0, 92.0], "value": 113.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 56.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 76.0, 77.0, 73.0, 69.0, 70.0, 71.0, 72.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 85.0, 89.0, 87.0, 82.0, 85.0, 95.0, 106.0, 108.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 143.0, 138.0, 157.0, 142.0, 143.0, 146.0, 169.0, 196.0, 141.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 170.0, 248.0, 246.0, 192.0, 173.0, 173.0, 200.0, 252.0, 226.0], "value": 208.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 69.0, 69.0, 72.0, 70.0, 72.0, 91.0, 70.0, 69.0], "value": 72.3, "unit": "score"}]}]} 09:20:34 INFO - Return code: 0 09:20:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:20:34 ERROR - # TBPL SUCCESS # 09:20:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:34 INFO - 2016-09-19 09:20:34.507 screenresolution[2017:13882] starting screenresolution argv=screenresolution get 09:20:34 INFO - 2016-09-19 09:20:34.510 screenresolution[2017:13882] Display 0: 1600x1200x32@60 09:20:34 INFO - 2016-09-19 09:20:34.516 screenresolution[2018:13885] starting screenresolution argv=screenresolution list 09:20:34 INFO - Available Modes on Display 0 09:20:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:34 INFO - Intel Iris: 09:20:34 INFO - Chipset Model: Intel Iris 09:20:34 INFO - Type: GPU 09:20:34 INFO - Bus: Built-In 09:20:34 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:34 INFO - Vendor: Intel (0x8086) 09:20:34 INFO - Device ID: 0x0a2e 09:20:34 INFO - Revision ID: 0x0009 09:20:34 INFO - Displays: 09:20:34 INFO - Display: 09:20:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:34 INFO - Display Serial Number: 1600x1200 60 09:20:34 INFO - Main Display: Yes 09:20:34 INFO - Mirror: Off 09:20:34 INFO - Online: Yes 09:20:34 INFO - Rotation: Supported 09:20:34 INFO - Return code: 0 09:20:34 INFO - Running post-action listener: _resource_record_post_action 09:20:34 INFO - [mozharness: 2016-09-19 16:20:34.755900Z] Finished run-tests step (success) 09:20:34 INFO - Running post-run listener: _resource_record_post_run 09:20:34 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 401408; Write bytes: 663255040; Read time: 7; Write time: 1896 09:20:34 INFO - TinderboxPrint: CPU usage
54.3% 09:20:34 INFO - TinderboxPrint: I/O read bytes / time
401,408 / 7 09:20:34 INFO - TinderboxPrint: I/O write bytes / time
663,255,040 / 1,896 09:20:34 INFO - TinderboxPrint: CPU idle
2,207.2 (45.7%) 09:20:34 INFO - TinderboxPrint: CPU system
981.9 (20.3%) 09:20:34 INFO - TinderboxPrint: CPU user
1,644.7 (34.0%) 09:20:34 INFO - TinderboxPrint: Swap in / out
363,200,512 / 0 09:20:34 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 359842304; Write bytes: 357024768; Read time: 27306; Write time: 706 09:20:34 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 356352; Write bytes: 294933504; Read time: 6; Write time: 1156 09:20:35 INFO - Running post-run listener: _upload_blobber_files 09:20:35 INFO - Blob upload gear active. 09:20:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:20:35 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:36 INFO - (blobuploader) - INFO - Done attempting. 09:20:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:20:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:37 INFO - (blobuploader) - INFO - Done attempting. 09:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:40 INFO - (blobuploader) - INFO - Done attempting. 09:20:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:40 INFO - Return code: 0 09:20:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1af5cc55e37f8152c1c4535f47d5f28502e8e1750d9d5b9c44e45d1f5ddbd1648a5b55d87d67dcde3abb7d6223ff516409917e99f6c9cab8e5cee77ffa37be9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970ddca72ddf433c50aa1dadf66f5381a30a461234650be305a6df8ce0435025ee4277c10e6456efd1d32996bb5d38e231fe72ca363806572f6118acfa24f22a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c250483f5e49cfeced2cc0e2c3aca3ef7e8f54c734de21d57412d53bd548f3e746367dfd4e5b79776c139d25592e46bf9586dc8e16e6f363c965ca10c92c08c0"} 09:20:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:40 INFO - Contents: 09:20:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1af5cc55e37f8152c1c4535f47d5f28502e8e1750d9d5b9c44e45d1f5ddbd1648a5b55d87d67dcde3abb7d6223ff516409917e99f6c9cab8e5cee77ffa37be9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970ddca72ddf433c50aa1dadf66f5381a30a461234650be305a6df8ce0435025ee4277c10e6456efd1d32996bb5d38e231fe72ca363806572f6118acfa24f22a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c250483f5e49cfeced2cc0e2c3aca3ef7e8f54c734de21d57412d53bd548f3e746367dfd4e5b79776c139d25592e46bf9586dc8e16e6f363c965ca10c92c08c0"} 09:20:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:40 INFO - Copying logs to upload dir... 09:20:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.698533 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-19 09:20:40.805868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 09:20:40.809487) ========= 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.lYMHBIQp73/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.MzjYEOBKKo/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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/1af5cc55e37f8152c1c4535f47d5f28502e8e1750d9d5b9c44e45d1f5ddbd1648a5b55d87d67dcde3abb7d6223ff516409917e99f6c9cab8e5cee77ffa37be9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970ddca72ddf433c50aa1dadf66f5381a30a461234650be305a6df8ce0435025ee4277c10e6456efd1d32996bb5d38e231fe72ca363806572f6118acfa24f22a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c250483f5e49cfeced2cc0e2c3aca3ef7e8f54c734de21d57412d53bd548f3e746367dfd4e5b79776c139d25592e46bf9586dc8e16e6f363c965ca10c92c08c0"} build_url:https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/bNqqo_BeSoyZBMDe37yicA/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/1af5cc55e37f8152c1c4535f47d5f28502e8e1750d9d5b9c44e45d1f5ddbd1648a5b55d87d67dcde3abb7d6223ff516409917e99f6c9cab8e5cee77ffa37be9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970ddca72ddf433c50aa1dadf66f5381a30a461234650be305a6df8ce0435025ee4277c10e6456efd1d32996bb5d38e231fe72ca363806572f6118acfa24f22a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c250483f5e49cfeced2cc0e2c3aca3ef7e8f54c734de21d57412d53bd548f3e746367dfd4e5b79776c139d25592e46bf9586dc8e16e6f363c965ca10c92c08c0"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 09:20:40.856276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:20:40.856679) ========= 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.lYMHBIQp73/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.MzjYEOBKKo/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005215 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:20:40.926101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 09:20:40.926687) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 09:20:40.927277) ========= ========= Total master_lag: 0.22 =========