builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0096 starttime: 1477216082.32 results: success (0) buildid: 20161023004025 builduid: d15bb9e033d44320bea75256c20473db revision: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:02.317627) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:02.318561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:02.318870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:02.342713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:02.343155) ========= 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.fA58Zgdkuv/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.oK00lM4Si7/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-23 02:48:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.1M=0.001s 2016-10-23 02:48:02 (10.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.599044 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:02.963744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:02.964060) ========= 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.fA58Zgdkuv/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.oK00lM4Si7/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.019394 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:03.013210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 02:48:03.013571) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 --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 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fA58Zgdkuv/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.oK00lM4Si7/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-23 02:48:03,088 truncating revision to first 12 chars 2016-10-23 02:48:03,088 Setting DEBUG logging. 2016-10-23 02:48:03,089 attempt 1/10 2016-10-23 02:48:03,089 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/96ca0ecdcfa7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 02:48:04,187 unpacking tar archive at: mozilla-aurora-96ca0ecdcfa7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.357961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 02:48:04.393191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:04.393528) ========= script_repo_revision: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:04.393923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:04.394186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 02:48:04.412562) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-23 02:48:04.412833) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fA58Zgdkuv/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.oK00lM4Si7/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:48:04 INFO - MultiFileLogger online at 20161023 02:48:04 in /builds/slave/test 02:48:04 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 02:48:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:04 INFO - {'append_to_log': False, 02:48:04 INFO - 'base_work_dir': '/builds/slave/test', 02:48:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:48:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:04 INFO - 'branch': 'Mozilla-Aurora', 02:48:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:04 INFO - 'config_files': ('talos/mac_config.py',), 02:48:04 INFO - 'default_actions': ('clobber', 02:48:04 INFO - 'read-buildbot-config', 02:48:04 INFO - 'download-and-extract', 02:48:04 INFO - 'populate-webroot', 02:48:04 INFO - 'create-virtualenv', 02:48:04 INFO - 'install', 02:48:04 INFO - 'run-tests'), 02:48:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:04 INFO - 'download_minidump_stackwalk': True, 02:48:04 INFO - 'download_symbols': 'ondemand', 02:48:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:04 INFO - 'installer_path': 'installer.exe', 02:48:04 INFO - 'log_level': 'info', 02:48:04 INFO - 'log_name': 'talos', 02:48:04 INFO - 'log_to_console': True, 02:48:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:04 INFO - 'opt_config_files': (), 02:48:04 INFO - 'pip_index': False, 02:48:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:04 INFO - 'cmd': ('bash', 02:48:04 INFO - '-c', 02:48:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:04 INFO - 'enabled': True, 02:48:04 INFO - 'halt_on_failure': False, 02:48:04 INFO - 'name': 'check_screen_resolution'},), 02:48:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:04 INFO - 'cmd': ('bash', 02:48:04 INFO - '-c', 02:48:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:04 INFO - 'enabled': True, 02:48:04 INFO - 'halt_on_failure': False, 02:48:04 INFO - 'name': 'check_screen_resolution'},), 02:48:04 INFO - 'run_cmd_checks_enabled': True, 02:48:04 INFO - 'sps_profile': False, 02:48:04 INFO - 'sps_profile_interval': 0, 02:48:04 INFO - 'suite': 'dromaeojs-e10s', 02:48:04 INFO - 'system_bits': '32', 02:48:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:04 INFO - 'title': 't-yosemite-r7-0096', 02:48:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:04 INFO - 'use_talos_json': True, 02:48:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:04 INFO - 'work_dir': 'build'} 02:48:04 INFO - [mozharness: 2016-10-23 09:48:04.620381Z] Running clobber step. 02:48:04 INFO - Running pre-action listener: _resource_record_pre_action 02:48:04 INFO - Running main action method: clobber 02:48:04 INFO - rmtree: /builds/slave/test/build 02:48:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:06 INFO - Running post-action listener: _resource_record_post_action 02:48:06 INFO - [mozharness: 2016-10-23 09:48:06.285223Z] Finished clobber step (success) 02:48:06 INFO - [mozharness: 2016-10-23 09:48:06.285349Z] Running read-buildbot-config step. 02:48:06 INFO - Running pre-action listener: _resource_record_pre_action 02:48:06 INFO - Running main action method: read_buildbot_config 02:48:06 INFO - Using buildbot properties: 02:48:06 INFO - { 02:48:06 INFO - "project": "", 02:48:06 INFO - "product": "firefox", 02:48:06 INFO - "script_repo_revision": "production", 02:48:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:48:06 INFO - "repository": "", 02:48:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:48:06 INFO - "buildid": "20161023004025", 02:48:06 INFO - "stage_platform": "macosx64", 02:48:06 INFO - "basedir": "/builds/slave/test", 02:48:06 INFO - "nightly_build": "True", 02:48:06 INFO - "buildnumber": 13, 02:48:06 INFO - "slavename": "t-yosemite-r7-0096", 02:48:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:48:06 INFO - "platform": "yosemite_r7", 02:48:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:48:06 INFO - "branch": "mozilla-aurora", 02:48:06 INFO - "repo_path": "releases/mozilla-aurora", 02:48:06 INFO - "revision": "96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79", 02:48:06 INFO - "pgo_build": "False", 02:48:06 INFO - "builduid": "d15bb9e033d44320bea75256c20473db", 02:48:06 INFO - "slavebuilddir": "test" 02:48:06 INFO - } 02:48:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:48:06 INFO - Running post-action listener: _resource_record_post_action 02:48:06 INFO - [mozharness: 2016-10-23 09:48:06.288859Z] Finished read-buildbot-config step (success) 02:48:06 INFO - [mozharness: 2016-10-23 09:48:06.288974Z] Running download-and-extract step. 02:48:06 INFO - Running pre-action listener: _resource_record_pre_action 02:48:06 INFO - Running main action method: download_and_extract 02:48:06 INFO - mkdir: /builds/slave/test/build/tests 02:48: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')]} 02:48:06 INFO - trying https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:06 INFO - Downloading https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 02:48:07 INFO - Downloaded 1199 bytes. 02:48:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:07 INFO - Using the following test package requirements: 02:48:07 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:48:07 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:48:07 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:48:07 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'jsshell-mac.zip'], 02:48:07 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:48:07 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:48:07 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:48:07 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:48:07 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:48:07 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:07 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:48:07 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:48:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:48:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:07 INFO - Fetch https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:48:07 INFO - Expected file size: 16436679 02:48:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:48:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:14 INFO - Fetch https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:48:15 INFO - Expected file size: 16436679 02:48:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:48:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:48:22 INFO - Fetch https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:48:23 INFO - Expected file size: 14414081 02:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:24 INFO - trying https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:24 INFO - Downloading https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 02:48:27 INFO - Downloaded 115563409 bytes. 02:48:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:27 INFO - mkdir: /builds/slave/test/properties 02:48:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:27 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:27 INFO - Contents: 02:48:27 INFO - build_url:https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:28 INFO - Running post-action listener: _resource_record_post_action 02:48:28 INFO - Running post-action listener: set_extra_try_arguments 02:48:28 INFO - [mozharness: 2016-10-23 09:48:28.122562Z] Finished download-and-extract step (success) 02:48:28 INFO - [mozharness: 2016-10-23 09:48:28.122677Z] Running populate-webroot step. 02:48:28 INFO - Running pre-action listener: _resource_record_pre_action 02:48:28 INFO - Running main action method: populate_webroot 02:48:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:28 INFO - '--tppagecycles', 02:48:28 INFO - '7'], 02:48:28 INFO - 'tests': ['tsvgm']}}, 02:48:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['damp', 'tps']}, 02:48:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'tests': ['damp', 'tps']}, 02:48:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['dromaeo_dom']}, 02:48:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['basic_compositor_video']}, 02:48:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:48:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['a11yr', 02:48:28 INFO - 'ts_paint', 02:48:28 INFO - 'tpaint', 02:48:28 INFO - 'sessionrestore', 02:48:28 INFO - 'sessionrestore_no_auto_restore', 02:48:28 INFO - 'tabpaint']}, 02:48:28 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:28 INFO - 'ts_paint', 02:48:28 INFO - 'tpaint', 02:48:28 INFO - 'sessionrestore', 02:48:28 INFO - 'sessionrestore_no_auto_restore', 02:48:28 INFO - 'tabpaint']}, 02:48:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:28 INFO - 'ts_paint', 02:48:28 INFO - 'tpaint', 02:48:28 INFO - 'sessionrestore', 02:48:28 INFO - 'sessionrestore_no_auto_restore', 02:48:28 INFO - 'tabpaint']}, 02:48:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:28 INFO - 'ts_paint', 02:48:28 INFO - 'tpaint', 02:48:28 INFO - 'sessionrestore', 02:48:28 INFO - 'sessionrestore_no_auto_restore', 02:48:28 INFO - 'tabpaint']}, 02:48:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['a11yr', 02:48:28 INFO - 'ts_paint', 02:48:28 INFO - 'tpaint', 02:48:28 INFO - 'sessionrestore', 02:48:28 INFO - 'sessionrestore_no_auto_restore', 02:48:28 INFO - 'tabpaint']}, 02:48:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['a11yr', 02:48:28 INFO - 'ts_paint', 02:48:28 INFO - 'tpaint', 02:48:28 INFO - 'sessionrestore', 02:48:28 INFO - 'sessionrestore_no_auto_restore', 02:48:28 INFO - 'tabpaint']}, 02:48:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['tsvgx', 02:48:28 INFO - 'tsvgr_opacity', 02:48:28 INFO - 'tart', 02:48:28 INFO - 'tscrollx', 02:48:28 INFO - 'cart']}, 02:48:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:28 INFO - 'tsvgr_opacity', 02:48:28 INFO - 'tart', 02:48:28 INFO - 'tscrollx', 02:48:28 INFO - 'cart']}, 02:48:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'talos_options': ['--disable-e10s'], 02:48:28 INFO - 'tests': ['tp5o']}, 02:48:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'tests': ['tp5o']}, 02:48:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'talos_options': ['--disable-e10s', 02:48:28 INFO - '--xperf_path', 02:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:28 INFO - 'tests': ['tp5n']}, 02:48:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:28 INFO - 'talos_options': ['--xperf_path', 02:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:28 INFO - 'tests': ['tp5n']}}, 02:48:28 INFO - 'talos.zip': {'path': '', 02:48:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:28 INFO - Running post-action listener: _resource_record_post_action 02:48:28 INFO - [mozharness: 2016-10-23 09:48:28.141415Z] Finished populate-webroot step (success) 02:48:28 INFO - [mozharness: 2016-10-23 09:48:28.141520Z] Running create-virtualenv step. 02:48:28 INFO - Running pre-action listener: _resource_record_pre_action 02:48:28 INFO - Running main action method: create_virtualenv 02:48:28 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:48:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:28 INFO - Using real prefix '/tools/python27' 02:48:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:31 INFO - Installing pip.................done. 02:48:31 INFO - Return code: 0 02:48:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:31 INFO - 'HOME': '/Users/cltbld', 02:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:31 INFO - 'LOGNAME': 'cltbld', 02:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:31 INFO - 'MOZ_NO_REMOTE': '1', 02:48:31 INFO - 'NO_EM_RESTART': '1', 02:48:31 INFO - 'PAGER': '/bin/cat', 02:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:31 INFO - 'PWD': '/builds/slave/test', 02:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:31 INFO - 'SHELL': '/bin/bash', 02:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:31 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:31 INFO - 'USER': 'cltbld', 02:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:31 INFO - 'XPC_FLAGS': '0x0', 02:48:31 INFO - 'XPC_SERVICE_NAME': '0', 02:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:48:32 INFO - Cleaning up... 02:48:32 INFO - Return code: 0 02:48:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:32 INFO - 'HOME': '/Users/cltbld', 02:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:32 INFO - 'LOGNAME': 'cltbld', 02:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:32 INFO - 'MOZ_NO_REMOTE': '1', 02:48:32 INFO - 'NO_EM_RESTART': '1', 02:48:32 INFO - 'PAGER': '/bin/cat', 02:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:32 INFO - 'PWD': '/builds/slave/test', 02:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:32 INFO - 'SHELL': '/bin/bash', 02:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:32 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:32 INFO - 'USER': 'cltbld', 02:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:32 INFO - 'XPC_FLAGS': '0x0', 02:48:32 INFO - 'XPC_SERVICE_NAME': '0', 02:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:32 INFO - Downloading/unpacking psutil>=3.1.1 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:35 INFO - Installing collected packages: psutil 02:48:35 INFO - Running setup.py install for psutil 02:48:36 INFO - building 'psutil._psutil_osx' extension 02:48:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:48:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:48:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:48:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:48:36 INFO - building 'psutil._psutil_posix' extension 02:48:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:48:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:36 INFO - ^ 02:48:36 INFO - 1 warning generated. 02:48:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:48:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:36 INFO - Successfully installed psutil 02:48:36 INFO - Cleaning up... 02:48:36 INFO - Return code: 0 02:48:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:36 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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:36 INFO - 'HOME': '/Users/cltbld', 02:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:36 INFO - 'LOGNAME': 'cltbld', 02:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:36 INFO - 'MOZ_NO_REMOTE': '1', 02:48:36 INFO - 'NO_EM_RESTART': '1', 02:48:36 INFO - 'PAGER': '/bin/cat', 02:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:36 INFO - 'PWD': '/builds/slave/test', 02:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:36 INFO - 'SHELL': '/bin/bash', 02:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:36 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:36 INFO - 'USER': 'cltbld', 02:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:36 INFO - 'XPC_FLAGS': '0x0', 02:48:36 INFO - 'XPC_SERVICE_NAME': '0', 02:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:48:39 INFO - Installing collected packages: mozsystemmonitor 02:48:39 INFO - Running setup.py install for mozsystemmonitor 02:48:39 INFO - Successfully installed mozsystemmonitor 02:48:39 INFO - Cleaning up... 02:48:39 INFO - Return code: 0 02:48:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:39 INFO - 'HOME': '/Users/cltbld', 02:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:39 INFO - 'LOGNAME': 'cltbld', 02:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:39 INFO - 'MOZ_NO_REMOTE': '1', 02:48:39 INFO - 'NO_EM_RESTART': '1', 02:48:39 INFO - 'PAGER': '/bin/cat', 02:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:39 INFO - 'PWD': '/builds/slave/test', 02:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:39 INFO - 'SHELL': '/bin/bash', 02:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:39 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:39 INFO - 'USER': 'cltbld', 02:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:39 INFO - 'XPC_FLAGS': '0x0', 02:48:39 INFO - 'XPC_SERVICE_NAME': '0', 02:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:40 INFO - Downloading/unpacking jsonschema==2.5.1 02:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:43 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:43 INFO - warning: no files found matching '*.txt' 02:48:43 INFO - no previously-included directories found matching 'build' 02:48:43 INFO - no previously-included directories found matching 'dist' 02:48:43 INFO - no previously-included directories found matching '.git*' 02:48:43 INFO - Installing collected packages: jsonschema, functools32 02:48:43 INFO - Running setup.py install for functools32 02:48:43 INFO - warning: no files found matching '*.txt' 02:48:43 INFO - no previously-included directories found matching 'build' 02:48:43 INFO - no previously-included directories found matching 'dist' 02:48:43 INFO - no previously-included directories found matching '.git*' 02:48:43 INFO - Successfully installed jsonschema functools32 02:48:43 INFO - Cleaning up... 02:48:43 INFO - Return code: 0 02:48:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:43 INFO - 'HOME': '/Users/cltbld', 02:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:43 INFO - 'LOGNAME': 'cltbld', 02:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:43 INFO - 'MOZ_NO_REMOTE': '1', 02:48:43 INFO - 'NO_EM_RESTART': '1', 02:48:43 INFO - 'PAGER': '/bin/cat', 02:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:43 INFO - 'PWD': '/builds/slave/test', 02:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:43 INFO - 'SHELL': '/bin/bash', 02:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:43 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:43 INFO - 'USER': 'cltbld', 02:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:43 INFO - 'XPC_FLAGS': '0x0', 02:48:43 INFO - 'XPC_SERVICE_NAME': '0', 02:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:48:43 INFO - Cleaning up... 02:48:43 INFO - Return code: 0 02:48:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:43 INFO - 'HOME': '/Users/cltbld', 02:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:43 INFO - 'LOGNAME': 'cltbld', 02:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:43 INFO - 'MOZ_NO_REMOTE': '1', 02:48:43 INFO - 'NO_EM_RESTART': '1', 02:48:43 INFO - 'PAGER': '/bin/cat', 02:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:43 INFO - 'PWD': '/builds/slave/test', 02:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:43 INFO - 'SHELL': '/bin/bash', 02:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:43 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:43 INFO - 'USER': 'cltbld', 02:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:43 INFO - 'XPC_FLAGS': '0x0', 02:48:43 INFO - 'XPC_SERVICE_NAME': '0', 02:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:46 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:47 INFO - Downloading docopt-0.6.1.tar.gz 02:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:47 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:47 INFO - Running setup.py install for blobuploader 02:48:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:47 INFO - Running setup.py install for requests 02:48:48 INFO - Running setup.py install for docopt 02:48:48 INFO - Successfully installed blobuploader requests docopt 02:48:48 INFO - Cleaning up... 02:48:48 INFO - Return code: 0 02:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:48 INFO - 'HOME': '/Users/cltbld', 02:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:48 INFO - 'LOGNAME': 'cltbld', 02:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:48 INFO - 'MOZ_NO_REMOTE': '1', 02:48:48 INFO - 'NO_EM_RESTART': '1', 02:48:48 INFO - 'PAGER': '/bin/cat', 02:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:48 INFO - 'PWD': '/builds/slave/test', 02:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:48 INFO - 'SHELL': '/bin/bash', 02:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:48 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:48 INFO - 'USER': 'cltbld', 02:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:48 INFO - 'XPC_FLAGS': '0x0', 02:48:48 INFO - 'XPC_SERVICE_NAME': '0', 02:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:48 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-auJeFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Acpg2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-13y56F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-V0wCe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-3N_AQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-ekXpFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-LmtngR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-lw0WEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-KqiqXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-O3_xrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:49 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-DOY8_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:50 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-1gkuOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:50 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-QatE48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:50 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-CabQdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:50 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-l0kTr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:50 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-rVREPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:50 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-dLb3dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:50 INFO - Running setup.py install for manifestparser 02:48:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:50 INFO - Running setup.py install for mozcrash 02:48:50 INFO - Running setup.py install for mozdebug 02:48:51 INFO - Running setup.py install for mozdevice 02:48:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for mozfile 02:48:51 INFO - Running setup.py install for mozhttpd 02:48:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for mozinfo 02:48:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for mozInstall 02:48:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Running setup.py install for mozleak 02:48:51 INFO - Running setup.py install for mozlog 02:48:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Running setup.py install for moznetwork 02:48:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Running setup.py install for mozprocess 02:48:52 INFO - Running setup.py install for mozprofile 02:48:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Running setup.py install for mozrunner 02:48:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:52 INFO - Running setup.py install for mozscreenshot 02:48:52 INFO - Running setup.py install for moztest 02:48:53 INFO - Running setup.py install for mozversion 02:48:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:53 INFO - Cleaning up... 02:48:53 INFO - Return code: 0 02:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:53 INFO - 'HOME': '/Users/cltbld', 02:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:53 INFO - 'LOGNAME': 'cltbld', 02:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:53 INFO - 'MOZ_NO_REMOTE': '1', 02:48:53 INFO - 'NO_EM_RESTART': '1', 02:48:53 INFO - 'PAGER': '/bin/cat', 02:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:53 INFO - 'PWD': '/builds/slave/test', 02:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:53 INFO - 'SHELL': '/bin/bash', 02:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:53 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:53 INFO - 'USER': 'cltbld', 02:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:53 INFO - 'XPC_FLAGS': '0x0', 02:48:53 INFO - 'XPC_SERVICE_NAME': '0', 02:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:53 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-yR2mmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:53 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-ZXuZJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:53 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-JlxSdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:53 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-TSsW9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:53 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-ZRboya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-LGOHKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-8m3hG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-PMBDIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-6bY3ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-iOYi3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-g7xHhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Ptv6T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-V9lANe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:54 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-_mdOXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:55 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-J1eg8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:55 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-GQCrXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:55 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-VpjHms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:57 INFO - Downloading blessings-1.6.tar.gz 02:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:58 INFO - Installing collected packages: blessings 02:48:58 INFO - Running setup.py install for blessings 02:48:58 INFO - Successfully installed blessings 02:48:58 INFO - Cleaning up... 02:48:58 INFO - Return code: 0 02:48:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:58 INFO - Reading from file tmpfile_stdout 02:48:58 INFO - Current package versions: 02:48:58 INFO - blessings == 1.6 02:48:58 INFO - blobuploader == 1.2.4 02:48:58 INFO - docopt == 0.6.1 02:48:58 INFO - functools32 == 3.2.3-2 02:48:58 INFO - jsonschema == 2.5.1 02:48:58 INFO - manifestparser == 1.1 02:48:58 INFO - mozInstall == 1.12 02:48:58 INFO - mozcrash == 0.17 02:48:58 INFO - mozdebug == 0.1 02:48:58 INFO - mozdevice == 0.48 02:48:58 INFO - mozfile == 1.2 02:48:58 INFO - mozhttpd == 0.7 02:48:58 INFO - mozinfo == 0.9 02:48:58 INFO - mozleak == 0.1 02:48:58 INFO - mozlog == 3.4 02:48:58 INFO - moznetwork == 0.27 02:48:58 INFO - mozprocess == 0.23 02:48:58 INFO - mozprofile == 0.28 02:48:58 INFO - mozrunner == 6.12 02:48:58 INFO - mozscreenshot == 0.1 02:48:58 INFO - mozsystemmonitor == 0.3 02:48:58 INFO - moztest == 0.7 02:48:58 INFO - mozversion == 1.4 02:48:58 INFO - psutil == 3.1.1 02:48:58 INFO - requests == 1.2.3 02:48:58 INFO - wsgiref == 0.1.2 02:48:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:58 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 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:58 INFO - 'HOME': '/Users/cltbld', 02:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:58 INFO - 'LOGNAME': 'cltbld', 02:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:58 INFO - 'MOZ_NO_REMOTE': '1', 02:48:58 INFO - 'NO_EM_RESTART': '1', 02:48:58 INFO - 'PAGER': '/bin/cat', 02:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:58 INFO - 'PWD': '/builds/slave/test', 02:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:58 INFO - 'SHELL': '/bin/bash', 02:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:58 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:58 INFO - 'USER': 'cltbld', 02:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:58 INFO - 'XPC_FLAGS': '0x0', 02:48:58 INFO - 'XPC_SERVICE_NAME': '0', 02:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:58 INFO - Cleaning up... 02:48:58 INFO - Return code: 0 02:48:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a985490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71c89490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, '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.fA58Zgdkuv/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.oK00lM4Si7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48: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', 'jsonschema'] in /builds/slave/test/build 02:48: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 jsonschema 02:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:58 INFO - 'HOME': '/Users/cltbld', 02:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:58 INFO - 'LOGNAME': 'cltbld', 02:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:58 INFO - 'MOZ_NO_REMOTE': '1', 02:48:58 INFO - 'NO_EM_RESTART': '1', 02:48:58 INFO - 'PAGER': '/bin/cat', 02:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:58 INFO - 'PWD': '/builds/slave/test', 02:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:58 INFO - 'SHELL': '/bin/bash', 02:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:48:58 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:58 INFO - 'USER': 'cltbld', 02:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:58 INFO - 'XPC_FLAGS': '0x0', 02:48:58 INFO - 'XPC_SERVICE_NAME': '0', 02:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:48:59 INFO - Cleaning up... 02:48:59 INFO - Return code: 0 02:48:59 INFO - Running post-action listener: _resource_record_post_action 02:48:59 INFO - Running post-action listener: _start_resource_monitoring 02:48:59 INFO - Starting resource monitoring. 02:48:59 INFO - [mozharness: 2016-10-23 09:48:59.088797Z] Finished create-virtualenv step (success) 02:48:59 INFO - [mozharness: 2016-10-23 09:48:59.089738Z] Running install step. 02:48:59 INFO - Running pre-action listener: _resource_record_pre_action 02:48:59 INFO - Running main action method: install 02:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:59 INFO - Reading from file tmpfile_stdout 02:48:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:59 INFO - Reading from file tmpfile_stdout 02:48:59 INFO - Output received: 02:48:59 INFO - Usage: mozinstall [options] installer 02:48:59 INFO - Options: 02:48:59 INFO - -h, --help show this help message and exit 02:48:59 INFO - -d DEST, --destination=DEST 02:48:59 INFO - Directory to install application into. [default: 02:48:59 INFO - "/builds/slave/test"] 02:48:59 INFO - --app=APP Application being installed. [default: firefox] 02:48:59 INFO - mkdir: /builds/slave/test/build/application 02:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:32 INFO - Reading from file tmpfile_stdout 02:49:32 INFO - Output received: 02:49:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:49:32 INFO - Running post-action listener: _resource_record_post_action 02:49:32 INFO - [mozharness: 2016-10-23 09:49:32.124747Z] Finished install step (success) 02:49:32 INFO - [mozharness: 2016-10-23 09:49:32.124917Z] Running run-tests step. 02:49:32 INFO - Running pre-action listener: _resource_record_pre_action 02:49:32 INFO - Running main action method: run_tests 02:49:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:32 INFO - 2016-10-23 02:49:32.139 screenresolution[1945:22177] starting screenresolution argv=screenresolution get 02:49:32 INFO - 2016-10-23 02:49:32.142 screenresolution[1945:22177] Display 0: 1600x1200x32@60 02:49:32 INFO - 2016-10-23 02:49:32.148 screenresolution[1946:22179] starting screenresolution argv=screenresolution list 02:49:32 INFO - Available Modes on Display 0 02:49:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:32 INFO - Intel Iris: 02:49:32 INFO - Chipset Model: Intel Iris 02:49:32 INFO - Type: GPU 02:49:32 INFO - Bus: Built-In 02:49:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:32 INFO - Vendor: Intel (0x8086) 02:49:32 INFO - Device ID: 0x0a2e 02:49:32 INFO - Revision ID: 0x0009 02:49:32 INFO - Displays: 02:49:32 INFO - Display: 02:49:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:32 INFO - Display Serial Number: 1600x1200 60 02:49:32 INFO - Main Display: Yes 02:49:32 INFO - Mirror: Off 02:49:32 INFO - Online: Yes 02:49:32 INFO - Rotation: Supported 02:49:32 INFO - Return code: 0 02:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:32 INFO - Python 2.7.3 02:49:32 INFO - Return code: 0 02:49:32 INFO - grabbing minidump binary from tooltool 02:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:32 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 0x10a799d30>, '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 0x10a5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a791b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:49:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:49:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:49:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:32 INFO - Return code: 0 02:49:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:32 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/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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 02:49:32 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/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0096 --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 02:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fA58Zgdkuv/Render', 02:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:32 INFO - 'HOME': '/Users/cltbld', 02:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:32 INFO - 'LOGNAME': 'cltbld', 02:49:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:32 INFO - 'MOZ_NO_REMOTE': '1', 02:49:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:32 INFO - 'NO_EM_RESTART': '1', 02:49:32 INFO - 'PAGER': '/bin/cat', 02:49:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:32 INFO - 'PWD': '/builds/slave/test', 02:49:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:32 INFO - 'SHELL': '/bin/bash', 02:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oK00lM4Si7/Listeners', 02:49:32 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:32 INFO - 'USER': 'cltbld', 02:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:32 INFO - 'XPC_FLAGS': '0x0', 02:49:32 INFO - 'XPC_SERVICE_NAME': '0', 02:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:32 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/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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 02:49:32 INFO - mozversion application_buildid: 20161023004025 02:49:32 INFO - mozversion application_changeset: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 02:49:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:49:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:32 INFO - mozversion application_name: Firefox 02:49:32 INFO - mozversion application_remotingname: firefox-dev 02:49:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:32 INFO - mozversion application_vendor: Mozilla 02:49:32 INFO - mozversion application_version: 51.0a2 02:49:32 INFO - mozversion platform_buildid: 20161023004025 02:49:32 INFO - mozversion platform_changeset: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 02:49:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:32 INFO - mozversion platform_version: 51.0a2 02:49:32 INFO - using testdate: 1477216172 02:49:32 INFO - actual date: 1477216172 02:49:32 INFO - starting webserver on 'localhost:52674' 02:49:32 INFO - SUITE-START | Running 2 tests 02:49:32 INFO - TEST-START | dromaeo_css 02:49:32 INFO - operating with platform_type : mac_ 02:49:32 INFO - Initialising browser for dromaeo_css test... 02:49:32 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpQyqxlL/profile http://localhost:52674/getInfo.html) 02:49:35 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 02:49:35 INFO - PROCESS | 1956 | colorDepth:24 02:49:35 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 02:49:35 INFO - PROCESS | 1956 | __metrics 02:49:35 ERROR - PROCESS | 1956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:49:36 INFO - TEST-INFO | 1956: exit 0 02:49:36 INFO - Browser initialized. 02:49:36 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:36 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpQyqxlL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:48 INFO - PROCESS | 1960 | RSS: Main: 225320960 02:49:48 INFO - PROCESS | 1960 | 02:50:37 INFO - PROCESS | 1960 | 1477216237934 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:52:49 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52674/tests/dromaeo/cssquery-ext.html) 02:52:51 INFO - PROCESS | 1960 | RSS: Main: 236679168 02:52:51 INFO - PROCESS | 1960 | 02:55:53 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-ext.html (next: http://localhost:52674/tests/dromaeo/cssquery-jquery.html) 02:55:54 INFO - PROCESS | 1960 | RSS: Main: 248610816 02:55:54 INFO - PROCESS | 1960 | 02:58:56 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52674/tests/dromaeo/cssquery-mootools.html) 02:58:56 INFO - PROCESS | 1960 | RSS: Main: 251068416 02:58:56 INFO - PROCESS | 1960 | 03:01:58 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52674/tests/dromaeo/cssquery-prototype.html) 03:01:59 INFO - PROCESS | 1960 | RSS: Main: 251359232 03:01:59 INFO - PROCESS | 1960 | 03:05:02 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52674/tests/dromaeo/cssquery-yui.html) 03:05:02 INFO - PROCESS | 1960 | RSS: Main: 255733760 03:05:02 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-yui.html (next: http://localhost:52674/tests/dromaeo/cssquery-dojo.html) 03:08:05 INFO - PROCESS | 1960 | RSS: Main: 258441216 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | __start_tp_report 03:08:05 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 03:08:05 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 03:08:05 INFO - PROCESS | 1960 | |i|pagename|runs| 03:08:05 INFO - PROCESS | 1960 | |0;dojo.html;3368.764186506945;3378.7465940054485;3382.5602671652664;3405.0976491229844;3439.810810405428;5602.719864006799;5643.943560564393;5685.602007859441;5687.289088863892;5705.429457054298;5032.993401319733;5408.134698448249;5625.5499560035205;5654.773809047633;5682.431756824316;5189.688618682872;5224.764885580158;5233.476652334755;5284.2602035714835;5289.20661900716;5235.842924712265;5256.211568264772;5258.973705131469;5275.736213189344;5296.25852380667;5163.225516172567;5188.455212202721;5270.2358158067245;5281.339832520935;5327.573794096463;4452.755098469583;5220.686758794484;5241.344831896013;5284.154535274338;5320;5107.668001579886;5214.6871187728475;5217.113090774577;5217.2695822584865;5316.20256961455;5053.898922021539;5437.9939711153165;5700.344460387067;5753.510951569122;5801.593888427812;6103.786367477162;6106.145139680449;6109.799438327934;6116.792316687807;6188.071789231606;4855.902881942341;5334.279872217278;6245.344238854946;6283.403076707706;6302.779402720883;4888.511148885119;5779.422057794271;5791.218185544982;5794.21778059965;5809;5527.226188333637;6079.331273559905;6237.96881015592;6247.718852651642;6262.12330273762;5978.0733986231335;6119.908201376983;6124.693765311717;6125.632462052291;6164.951958167122;5157.94262176253;5213.921791173136;6258.342873998165;6274.560780745395;6280.874382512324;5624.29696287964;6012.549058820518;6077.848053798691;6110.224634763396;6134.957077260912;6101.60339577926;6130.969345153246;6142.477889379364;6149.723262453201;6155.35368786271;4225.81677130404;4575.22221222393;4831.106245344622;4861.611071114302;4882.5605695486865;4302.548232435612;4314.41755363022;4319.33050377192;4319.935200971988;4387.780610969438;5782.826515204551;5800.506956908625;5844.9415505845245;5875.794347197828;5898.705064746746;5367.194920761917;6141.723622437001;6269.373062693785;6280.214973128359;6286.49708023357;5671.347795003545;5712.514436272881;5795.956727788954;5829.125631155276;5838.4453476919625;5419.430959749248;5420.403755586961;5420.674759514442;5430.538404235605;5437;6293.433590976834;6304.590201636879;6309.589876658002;6313.55805093639;6332.556721029576;6126.181801871033;6170.259568851767;6196.411340922786;6266.310705822447;6286.528510361833;6239.719212635351;6277.30949595535;6296.622202667854;6304.401081897213;6344.080108384351;6171.321154673072;6186.505079593711;6191.288001879841;6199.535034872493;6238.500919926304;6143.1706719592285;6143.972489078504;6150.630962142286;6276.403741644536;6292.937070629235;4966.758310422394;6023.247094113236;6035.818925432244;6087.604305720114;6125.877482450415;6063.575549711654;6066.393360663898;6077.878442431038;6082.847928801639;6103.816885493442;5779.335376431596;5784.768609255582;5908.675022873783;5970.820875373745;5979.5814292999075;4931.827386041471;6003.729832157476;6023.337432882292;6044.879102418015;6111.561351782648;4853.417589889236;5005.074061298671;5870.853228669317;5897.587168898136;5926.674032928058 03:08:05 INFO - PROCESS | 1960 | |1;ext.html;442.81844443778056;464.9116667833112;480.5194805194806;511.8131881863119;551.2117671729426;39561.2087758245;41422.17155656885;41506.16987660245;41549.3767593486;41627.16745665089;42975.35536966948;43235.35146972798;43372.783136084356;43374.56625433745;43495;9693;9860.35907666003;9881.901180988207;9910.306278560503;9964.750881227956;9806.607735690564;9809.558569864337;9818.803623927517;9863.112319891208;9875.1112399884;9867;9912.603495860158;9919.50402479873;9921.107100360967;9923.305368624198;9836.06557377048;9883.01169883013;9885.258605604537;9905.108540231342;9914.9504252479;8677.479351238946;9787.608495660164;9886.703398898044;9892.505374731234;9903.207743380512;40305.79847100775;40560.79719601413;40743.7962810187;40915.59084409148;40996;3336.916577085568;3456.9827150864335;3461.6538346165435;3465.8440370183403;3467.2025434150037;30129.698703013128;30751.538726919112;30792.538111928337;30806.84596577025;31095.378092438026;3126.5622812806228;3254.332861763333;3256.3161736035463;3262;3271.7382609391193;529090;535658;536632;539362;539538;32986.17534561655;62694.68652656708;62719.43201420001;63234;63492.365076348644;33764.49353259703;34230.65769342275;34762.65237347645;35067.64932350644;35160.82419587886;14515.782263266059;14637.487687931085;14853.851461485247;14920.70158596822;15060;12439.315837629018;12706.936465317614;12830.67923301925;12885.355732213351;12902.903253223394;7718.961405192938;7722.11195712489;7777.377809775205;7799.259070388304;7802.609869506502;3234.1267857678768;3272.7054565089256;3281;3285.3265080658407;3287.967120328814;921.424109931293;967.3035414501547;973.8636590877283;988.9357191782511;1010.7321559786662;27071.91712331524;30672.53991190134;30984.0704778857;31622.209444764067;32759.18102047468;1073.656429942411;1080.6757972608343;1095.5782023920688;1164.7845148647527;1168.8772678868766;15056.247187640793;15140.848591514165;15184.924075379773;15242.618934526725;15475.071495710068;677649;693514;695721;696617;697899;52900;53358.46641533612;53377.73311133419;53465.930681386155;53630.73184634052;1336.4587342126454;1367.8768910797876;1375.4154484344115;1383.8339399272152;1387.278615120132;28405.147845564665;28959;29030.7096929028;29579.704202957695;29585.704142959155;39781.00547486336;48555;49094.509054908995;49203.50796492132;49210.75394623004;601272;646896.5310346836;665061;666170;667184;23010.539789203787;25210.74789252084;25358.873205633852;26558;27248.318792030357;46479.535204647524;46588.53411465978;46589.76705116453;46671.76664116658;47729.045419090726;31456.685433146293;33782.83108584442;37871;38520.422193666556;38676.90584753269;30485;37349;37779.244415110996;37905;38248.235035299695;31978.84010579932;32528.349433010735;36502.45246321254;37953;39002.804985974886;25663;27623.58564621492;33785.83107084449;33841.49237761485;35717.82141089278;25443.36391590225;25503;25561.23316300514;25660.615090774027;26063.045271604326 03:08:05 INFO - PROCESS | 1960 | |2;jquery.html;371.9795411252382;375.51558489548484;379.84616230426667;385.60668118519095;397.59246772058634;18717;19298.74558153719;21414;21776;22030.559388812213;21106.788932110674;21165.788342116575;21369.14523419065;21519.784802151975;21668.674969875425;5904.97047514764;5923.466887980092;6119.724612392453;6202.3487533808975;6217.471514921237;4205.2851015327315;4441.511433742286;6097.451229389354;6116.938830611703;6372.776952806653;6584.802455926306;6588.044733513638;6618;6706.39642432181;6723.731050757989;6455.548111632188;6672.132622759059;6719.193696756421;6722.697478613474;6726.529142959995;5794.101914203306;5794.739236734357;5806;5843.211166492554;5850.795222167204;23971.400714982265;24288.878555607287;24296.149634762874;24351.391215219584;24374.39064023396;2098.3600001999384;2422.7577242275806;2908.7382135607895;3111.828849413281;3125.890593829228;10202.846957295647;10207.234457415649;10215.846762298572;10397.896021039769;10510.684679459628;1854.6754317994432;1867.7758668959675;1875.9062046897736;1910.2836436336374;1961.9509512262166;132371;135807;138189;139616.30191849076;141380;9335.533223338805;9934.552945117486;9975.551100200508;9987.900120998842;10159.9492002541;12553.748925021448;12563;12606.306653134166;12665.683357916127;12667.303298318497;8098.919010809935;8231.95884020588;8236.752897413087;8262.256396924306;8313.836062951192;8636.438631488933;8728.214460698568;8764;8850.734477965543;8878.51168185756;3818.1981783825154;3834.616538346143;3947.348687466593;3967.0677390813134;3972.7616343019513;1596.7525033619806;1646.2180464279372;1679.3534489221493;1937.205745644279;1991.5817678287722;763.343544508407;845.2984023260678;860.2601762484259;1024.8052869954834;1032.2258306270298;20753.58492830135;21438.78561214399;21570;21646.78353216479;21896.45258868541;896.6278994217326;929.1776777551916;941.6704153546341;952.6332362040525;1000.1198944928417;10027.04743049409;10634.564333814991;11299.423802900952;11371.090312774959;11443.713907152222;611412;626924;631910;633487;637137;131995;134897;136207.63792362149;137642;138135.30932345273;921.4609453469661;951.0869565217331;970;973.7176218896583;974.0503009565617;15504;18426.81573184251;18661.533461663566;18719.532011699815;18969.33607323737;35036.824815875756;36596.81701591475;53462.73268633632;53512.73243633757;55791.44208557862;58439.831203374844;73119.26880731125;76657.1671416438;79920;84192.57903710443;7090.184628767758;7255.455840811855;7444.404447644284;7514.774556763306;7529.096508419025;9346.345755797029;9582.90417095848;11031.503582338653;12973.481060757464;13058.477660893837;11120.165987551129;11154.721131971766;11428.71428214268;11442.82835757481;11795.882041179822;11223.943880280547;11258.605948791754;11482.081433485135;11498.367589782642;11636.883631163919;11412.372319522174;11578.36319002463;11717.824232636347;11905.523779049088;11955;7116.288371162842;7471.925280747123;7499.775006749806;8276.337892968668;8339;8219.178082191733;10430.791384172426;11464.4267786612;11706.88293117058;11771.646850594496 03:08:05 INFO - PROCESS | 1960 | |3;mootools.html;1563.5387560669599;1576.156756135467;1584.1762283612522;1761.8547943836513;1879.7650293713286;7790.532568045915;8117.431779775403;8401.66393344267;9090.181883630481;9125.726228213156;8534.957325213365;8857.11428857114;8890.244329232022;8963.641454341818;8988.191062804346;2401.6997875265633;2439.377958620549;2442.5969714997004;2445.461998360358;2447.339218411028;2407.9157229496973;2412.300432874464;2428.453597940467;2438.426969662128;2450.6324051392257;2422.2491027781357;2428.7449817769143;2433.4889673168655;2443.621238708003;2449.4243852694603;2391.820613453989;2399.6400539918977;2406.855588664677;2417.395651087228;2420.3465064432503;2396.7363590005084;2408.7952524035477;2408.9397765056015;2410.421498840283;2416.347586151747;9049.683261085896;9064.864027039599;9128.45229286245;9132.99537050924;9142.405743626643;5238.502342277516;5307.991481618519;5312.601554883399;5349.812756553541;5405.891882162374;3578.6063533011347;3686.7234957378305;3721.0139313081786;3728.2543491301576;3751.9437208441623;1077.1974878715407;1097.6432659385653;1107.9169062320277;1127.6222465474077;1128.8983991440728;10790.78418431627;11050.502727377287;11820.23168494045;11977.820332695017;12016.339101349422;4246.787660616957;4625.398698169284;4727.558094781125;4743.8794174320665;4901.681390709664;9950.552225149886;10040;10106.292559520763;10142.594296228215;10156.289059765893;4257.638100761408;4603.930941035887;5184.429712731597;5395.730213489388;5407.188921661704;3953.644172024474;4335.631471324973;4485.842995495142;4770.76146192689;4924.704517728947;3995.2808494471274;3995.300822356076;4040.939385909214;4079.1841631673783;4092.2224777292217;1273.9681507962375;1279.405076639367;1303.7262174943369;1314.5530519623373;1327.8273824402766;769.7228997560874;875.1292463998235;914.2640174659463;916.1800188831093;932.6362718539775;5908.438698323653;5932.228810254725;5955.612885162451;6096.780643871243;6147.538934579835;861.0571424290392;915.4736026784625;947.625687853294;979.1236843025453;988.9505524723735;3941.2117576484816;4075.470188875427;4088.0801819590947;4119.114390406077;4167.854125105607;9407.623695052258;10715.946420267848;11063.170262230204;11091.057260132819;11127.72180695489;10362.171026317876;10807.513661885234;10828.512716927757;11042.723931901606;11043.171762117874;8242.052164001097;8431.789205269917;8489.745307640904;8490.957545212234;8514.361422893307;6028.8794224116145;6094.329623741296;6109.6639684817765;6120.326764056039;6213.1922850029205;9953.303268771117;10224.693259202237;10302.896971030494;10407.895921040692;10456.63401780934;9494.810103798023;10202.846957295795;10312.071913527818;10369.74075648115;10631.308964917256;7045.788626341218;7235.384992275715;7449.292317229854;7637.541747495168;7697.46117771773;8428.704995325133;8450.788730281793;8588.012378576293;8588.441751286146;8624.913750862412;7527.6988920444755;7584.962075189809;7666.846663066819;7753.844923101619;7793.220677932161;7461.179270280373;7471.626418679153;7491.43814213947;7590.848183036419;7652.273034061755;6952.478564107813;7082.964585177041;7095.3968912643;7095.722769901261;7097.219305876246;4973.3144102184415;5035.949640503548;5144.6398752087;5195.402528709247;5240.2663627093;4812.735299558558;4935.605151587936;5043.4956504349275;5050.444451110448;5111.718855462986 03:08:05 INFO - PROCESS | 1960 | |4;prototype.html;299.3623581770829;308.4540363556505;308.577249168639;308.76071044940153;309.66710785905144;5070.898582028357;5229.111051121309;5342.278792363029;5393.191021346795;5398.6490878092945;4376.168527979682;4414.139242847646;4663.930041049387;5036.597072234222;5189.247559103937;3636.3272794532963;3840.558335791378;3896.961030389688;4048.817803198863;4071.837126514951;3192.569003184575;3388.966110338902;3449.9827500862584;3698.5746639136573;3937.798971313748;3365.444701624229;4007.6593489553425;4033.1328764315813;4048;4069.572694867041;3459.564280823455;3539.4159963605975;3918.1380096378753;4071.534247670836;4083.448734420845;2962.348283377675;3147.733631785111;3526.994806480141;3555.1823080691584;3575;4947.678400903966;5087.79648814047;5094.286799848024;5130.615203859688;5164.406093299243;4608.018552022629;4615.83844565442;4628.3288923105965;4630.050839577879;4644.724085198262;4913.950860491421;5325.7869685212545;5531.778728850841;5532.17858891968;5614.494695477427;3529.5235143255845;3765.1340191755776;3881.262560113598;3882.2041481496226;3889.9416508752392;5387.434319396446;5830.183774271605;5859.589828711992;5904.439078287556;5927;3158.57359256502;3623.836927338276;3695.519582454264;3855.325318069327;3865.3958607177706;3798.677112445473;3927.842886284574;3932.4297976793205;3932.744371615836;3942.526896772348;4155.449782488171;4164.58404142593;4522.3668686383935;4533.84131555394;4537.931931021038;4745.667803253739;5676.956295733533;5696.20253164549;5704.832163777738;5712.971435142797;1261.6593519749615;1295.4105881823937;1302.9543965961336;1325.0592079623575;1335.6861137632648;836.6736972580699;876.548577482597;877.6840337478502;893.3300024981264;903.5572569441058;4579.855231015936;4972.602191824645;5231.848993221485;5323.121684922022;5325.760340784674;4574.405327307429;5092.032513822362;5726.310738332202;5735.942640573541;5752.935706894238;5162.070827251131;5165.586753059746;5420.159875219348;5451;5470.64440811346;2820.971790282112;3005.443992861328;3009.6087508623737;3044.528098144791;3087.2899233176045;5533.557315414757;5704.80033198836;5880.066186878245;5961.5826892118;6058.727357268934;4709.270063140219;5014.598832093424;5459.481349271813;5865.715199488301;5964.850878728066;5168.457311982188;5600.691961942132;5739.823336215982;6080.483158931452;6117.265928088569;5332.653632401731;5770.538356931352;5779.739911704068;5841.240638716939;5875.20684707559;4773.663374255214;5629.4652008059165;5796.594238403271;5809.593328466966;5826.82519524415;5185.9887321971855;5746.540276777764;5979.641221526722;6042.84892877664;6120.571559990758;3979.184267225154;4041.454403655469;4047.534533528564;4048.473698419187;4075.694322925852;5400.8649783754145;5762.423757624204;5782.595218334676;5824.650520968756;5834.795782147605;4834.6374021947795;5181.870453238699;5581.274434323512;5643.746031428677;5664.348599911063;5587.329520457572;5601.187827765033;5605.215269862304;5606;5718.370979192368;5060.822871199491;5284.630075894805;5361.337985224593;5470.206820010996;5539.224508568885;5261.553377679397;5606.887862242651;5688.203651488878;5691.544676425959;5700.546360678167;5202.803355228394;5498.477644623755;5578.721063946705;5581.553475722014;5599.80400685974 03:08:05 INFO - PROCESS | 1960 | |5;yui.html;716.2980279326264;741.5328343143818;753.4178225725976;798.1140933563745;831.9875201871973;13789.517366892149;15614.843851561482;15686.921565392156;15723.764143537855;15741.60645983851;13749.65625859354;14011.579652610413;14033.649158771035;14048.157110573373;14131.434742610309;842.7387509871944;850.4344610833818;860.3547339495378;866.2420382165606;866.5320726807548;667.9699413526379;676.7901950395393;697.6616341074575;856.7130011446142;859.6088779605265;903.6430609909082;910.9362344635845;912.3932584831113;912.5346073502495;914.9130832570895;889.488544087146;904.9819003619924;905.1717678324326;906.0531744327128;907.7367563406605;662.1822049768532;676.509530590323;677.1298880937971;679.3817625960353;680.0105845994116;15379.154146521936;15521.767173492406;15538;15562.688746225012;15572.143532105729;14549.70900581993;14551.927240363837;14557.708845823025;14822.258887055605;14839.258037098101;11611.883881161164;11880.584179553674;11972.70068248292;11984.760304793943;12411.255324680547;3805.847766089353;3814.8855534334016;3831.578526362098;3849.076221706798;3863.111484358585;102795.97204028013;105599.4720026395;105828.470857646;115870;120570;10938.289011214245;11021.393823339793;11044.171687123498;11081.667549973514;11152.275102118336;21886.343409697416;22110.557788844133;22113.336599902028;22155;22179.223727169472;8080.515169089874;8185.672573097009;8191;8256.234161555825;8391.496510209407;4388.9935394255035;4423.203823311835;4517.706349087364;4550.726956382561;4571.085782843445;3608.224231790178;3696.5748938871834;3705.555333360014;3729.328720830277;3765.811709414518;672.364615438406;680.7311112110689;685.8148299959083;687.6046273392819;691.5263044814318;538.0691403871325;582.8426324892255;637.2671427858;641.7561326695919;681.7409384433884;9335.859962100438;9511;9546;9851;9980.45107519079;621.5307442880596;649.4771708774388;668.0293135251029;694.1496666583496;694.4062826283556;3815.6565909068318;4140;4510.391097201901;4587.7017993830295;4720.905581888343;83251;107246;120493;163110;164162.1791891057;97229.51385243029;139888.10391636446;142680;142760.28619857042;146823;120089;120625;120988.99999999824;122295;124000;9012.909870901469;9228.215601673934;9231.215346695606;9238.815223695354;9251.907480925374;49573.504264956886;53907;64759;67341.66329168323;67855.3214467849;78978.6051069741;98964.50517747653;102075.48962255141;105561;105564.47217763861;11745.530178793095;11762.3530705812;11857.525698971944;11996.220245684002;12499.125061245626;11402.315861048364;12629.621111366674;13124;13185.802212967004;13263.535776247785;11202.38386888729;11517.193796434169;11888.286702797513;11944;12203.938980305042;10240.283180177315;10625.734356641145;12253.019758419483;12546.811797822857;12832.037597180062;11859.22915010556;11873.940630296793;12221.572244971383;12234.449449774604;12714.745705086032;10154.847677284699;10410;10682.946585267024;10893.346399216072;10903.34579925207;10417.687469375627;10659.934006599588;10700.41147736882;10711.303765255234;10794.946025269823 03:08:05 INFO - PROCESS | 1960 | __end_tp_report 03:08:05 INFO - PROCESS | 1960 | __start_cc_report 03:08:05 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,368 03:08:05 INFO - PROCESS | 1960 | __end_cc_report 03:08:05 INFO - PROCESS | 1960 | __startTimestamp1477217285535__endTimestamp 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | ------- Summary: start ------- 03:08:05 INFO - PROCESS | 1960 | Number of tests: 6 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | [#0] dojo.html Cycles:165 Average:5645.73 Median:5809.00 stddev:657.02 (11.3%) stddev-sans-first:634.29 03:08:05 INFO - PROCESS | 1960 | Values: 3368.8 3378.7 3382.6 3405.1 3439.8 5602.7 5643.9 5685.6 5687.3 5705.4 5033.0 5408.1 5625.5 5654.8 5682.4 5189.7 5224.8 5233.5 5284.3 5289.2 5235.8 5256.2 5259.0 5275.7 5296.3 5163.2 5188.5 5270.2 5281.3 5327.6 4452.8 5220.7 5241.3 5284.2 5320.0 5107.7 5214.7 5217.1 5217.3 5316.2 5053.9 5438.0 5700.3 5753.5 5801.6 6103.8 6106.1 6109.8 6116.8 6188.1 4855.9 5334.3 6245.3 6283.4 6302.8 4888.5 5779.4 5791.2 5794.2 5809.0 5527.2 6079.3 6238.0 6247.7 6262.1 5978.1 6119.9 6124.7 6125.6 6165.0 5157.9 5213.9 6258.3 6274.6 6280.9 5624.3 6012.5 6077.8 6110.2 6135.0 6101.6 6131.0 6142.5 6149.7 6155.4 4225.8 4575.2 4831.1 4861.6 4882.6 4302.5 4314.4 4319.3 4319.9 4387.8 5782.8 5800.5 5844.9 5875.8 5898.7 5367.2 6141.7 6269.4 6280.2 6286.5 5671.3 5712.5 5796.0 5829.1 5838.4 5419.4 5420.4 5420.7 5430.5 5437.0 6293.4 6304.6 6309.6 6313.6 6332.6 6126.2 6170.3 6196.4 6266.3 6286.5 6239.7 6277.3 6296.6 6304.4 6344.1 6171.3 6186.5 6191.3 6199.5 6238.5 6143.2 6144.0 6150.6 6276.4 6292.9 4966.8 6023.2 6035.8 6087.6 6125.9 6063.6 6066.4 6077.9 6082.8 6103.8 5779.3 5784.8 5908.7 5970.8 5979.6 4931.8 6003.7 6023.3 6044.9 6111.6 4853.4 5005.1 5870.9 5897.6 5926.7 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | [#1] ext.html Cycles:180 Average:73227.39 Median:38839.86 stddev:169052.70 (435.3%) stddev-sans-first:169438.61 03:08:05 INFO - PROCESS | 1960 | Values: 442.8 464.9 480.5 511.8 551.2 39561.2 41422.2 41506.2 41549.4 41627.2 42975.4 43235.4 43372.8 43374.6 43495.0 9693.0 9860.4 9881.9 9910.3 9964.8 9806.6 9809.6 9818.8 9863.1 9875.1 9867.0 9912.6 9919.5 9921.1 9923.3 9836.1 9883.0 9885.3 9905.1 9915.0 8677.5 9787.6 9886.7 9892.5 9903.2 40305.8 40560.8 40743.8 40915.6 40996.0 3336.9 3457.0 3461.7 3465.8 3467.2 30129.7 30751.5 30792.5 30806.8 31095.4 3126.6 3254.3 3256.3 3262.0 3271.7 529090.0 535658.0 536632.0 539362.0 539538.0 32986.2 62694.7 62719.4 63234.0 63492.4 33764.5 34230.7 34762.7 35067.6 35160.8 14515.8 14637.5 14853.9 14920.7 15060.0 12439.3 12706.9 12830.7 12885.4 12902.9 7719.0 7722.1 7777.4 7799.3 7802.6 3234.1 3272.7 3281.0 3285.3 3288.0 921.4 967.3 973.9 988.9 1010.7 27071.9 30672.5 30984.1 31622.2 32759.2 1073.7 1080.7 1095.6 1164.8 1168.9 15056.2 15140.8 15184.9 15242.6 15475.1 677649.0 693514.0 695721.0 696617.0 697899.0 52900.0 53358.5 53377.7 53465.9 53630.7 1336.5 1367.9 1375.4 1383.8 1387.3 28405.1 28959.0 29030.7 29579.7 29585.7 39781.0 48555.0 49094.5 49203.5 49210.8 601272.0 646896.5 665061.0 666170.0 667184.0 23010.5 25210.7 25358.9 26558.0 27248.3 46479.5 46588.5 46589.8 46671.8 47729.0 31456.7 33782.8 37871.0 38520.4 38676.9 30485.0 37349.0 37779.2 37905.0 38248.2 31978.8 32528.3 36502.5 37953.0 39002.8 25663.0 27623.6 33785.8 33841.5 35717.8 25443.4 25503.0 25561.2 25660.6 26063.0 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | [#2] jquery.html Cycles:180 Average:36249.75 Median:19081.36 stddev:105239.50 (551.5%) stddev-sans-first:105500.24 03:08:05 INFO - PROCESS | 1960 | Values: 372.0 375.5 379.8 385.6 397.6 18717.0 19298.7 21414.0 21776.0 22030.6 21106.8 21165.8 21369.1 21519.8 21668.7 5905.0 5923.5 6119.7 6202.3 6217.5 4205.3 4441.5 6097.5 6116.9 6372.8 6584.8 6588.0 6618.0 6706.4 6723.7 6455.5 6672.1 6719.2 6722.7 6726.5 5794.1 5794.7 5806.0 5843.2 5850.8 23971.4 24288.9 24296.1 24351.4 24374.4 2098.4 2422.8 2908.7 3111.8 3125.9 10202.8 10207.2 10215.8 10397.9 10510.7 1854.7 1867.8 1875.9 1910.3 1962.0 132371.0 135807.0 138189.0 139616.3 141380.0 9335.5 9934.6 9975.6 9987.9 10159.9 12553.7 12563.0 12606.3 12665.7 12667.3 8098.9 8232.0 8236.8 8262.3 8313.8 8636.4 8728.2 8764.0 8850.7 8878.5 3818.2 3834.6 3947.3 3967.1 3972.8 1596.8 1646.2 1679.4 1937.2 1991.6 763.3 845.3 860.3 1024.8 1032.2 20753.6 21438.8 21570.0 21646.8 21896.5 896.6 929.2 941.7 952.6 1000.1 10027.0 10634.6 11299.4 11371.1 11443.7 611412.0 626924.0 631910.0 633487.0 637137.0 131995.0 134897.0 136207.6 137642.0 138135.3 921.5 951.1 970.0 973.7 974.1 15504.0 18426.8 18661.5 18719.5 18969.3 35036.8 36596.8 53462.7 53512.7 55791.4 58439.8 73119.3 76657.2 79920.0 84192.6 7090.2 7255.5 7444.4 7514.8 7529.1 9346.3 9582.9 11031.5 12973.5 13058.5 11120.2 11154.7 11428.7 11442.8 11795.9 11223.9 11258.6 11482.1 11498.4 11636.9 11412.4 11578.4 11717.8 11905.5 11955.0 7116.3 7471.9 7499.8 8276.3 8339.0 8219.2 10430.8 11464.4 11706.9 11771.6 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | [#3] mootools.html Cycles:180 Average:5782.63 Median:4791.75 stddev:3231.12 (67.4%) stddev-sans-first:3224.63 03:08:05 INFO - PROCESS | 1960 | Values: 1563.5 1576.2 1584.2 1761.9 1879.8 7790.5 8117.4 8401.7 9090.2 9125.7 8535.0 8857.1 8890.2 8963.6 8988.2 2401.7 2439.4 2442.6 2445.5 2447.3 2407.9 2412.3 2428.5 2438.4 2450.6 2422.2 2428.7 2433.5 2443.6 2449.4 2391.8 2399.6 2406.9 2417.4 2420.3 2396.7 2408.8 2408.9 2410.4 2416.3 9049.7 9064.9 9128.5 9133.0 9142.4 5238.5 5308.0 5312.6 5349.8 5405.9 3578.6 3686.7 3721.0 3728.3 3751.9 1077.2 1097.6 1107.9 1127.6 1128.9 10790.8 11050.5 11820.2 11977.8 12016.3 4246.8 4625.4 4727.6 4743.9 4901.7 9950.6 10040.0 10106.3 10142.6 10156.3 4257.6 4603.9 5184.4 5395.7 5407.2 3953.6 4335.6 4485.8 4770.8 4924.7 3995.3 3995.3 4040.9 4079.2 4092.2 1274.0 1279.4 1303.7 1314.6 1327.8 769.7 875.1 914.3 916.2 932.6 5908.4 5932.2 5955.6 6096.8 6147.5 861.1 915.5 947.6 979.1 989.0 3941.2 4075.5 4088.1 4119.1 4167.9 9407.6 10715.9 11063.2 11091.1 11127.7 10362.2 10807.5 10828.5 11042.7 11043.2 8242.1 8431.8 8489.7 8491.0 8514.4 6028.9 6094.3 6109.7 6120.3 6213.2 9953.3 10224.7 10302.9 10407.9 10456.6 9494.8 10202.8 10312.1 10369.7 10631.3 7045.8 7235.4 7449.3 7637.5 7697.5 8428.7 8450.8 8588.0 8588.4 8624.9 7527.7 7585.0 7666.8 7753.8 7793.2 7461.2 7471.6 7491.4 7590.8 7652.3 6952.5 7083.0 7095.4 7095.7 7097.2 4973.3 5035.9 5144.6 5195.4 5240.3 4812.7 4935.6 5043.5 5050.4 5111.7 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | [#4] prototype.html Cycles:180 Average:4532.58 Median:5163.24 stddev:1414.42 (27.4%) stddev-sans-first:1382.24 03:08:05 INFO - PROCESS | 1960 | Values: 299.4 308.5 308.6 308.8 309.7 5070.9 5229.1 5342.3 5393.2 5398.6 4376.2 4414.1 4663.9 5036.6 5189.2 3636.3 3840.6 3897.0 4048.8 4071.8 3192.6 3389.0 3450.0 3698.6 3937.8 3365.4 4007.7 4033.1 4048.0 4069.6 3459.6 3539.4 3918.1 4071.5 4083.4 2962.3 3147.7 3527.0 3555.2 3575.0 4947.7 5087.8 5094.3 5130.6 5164.4 4608.0 4615.8 4628.3 4630.1 4644.7 4914.0 5325.8 5531.8 5532.2 5614.5 3529.5 3765.1 3881.3 3882.2 3889.9 5387.4 5830.2 5859.6 5904.4 5927.0 3158.6 3623.8 3695.5 3855.3 3865.4 3798.7 3927.8 3932.4 3932.7 3942.5 4155.4 4164.6 4522.4 4533.8 4537.9 4745.7 5677.0 5696.2 5704.8 5713.0 1261.7 1295.4 1303.0 1325.1 1335.7 836.7 876.5 877.7 893.3 903.6 4579.9 4972.6 5231.8 5323.1 5325.8 4574.4 5092.0 5726.3 5735.9 5752.9 5162.1 5165.6 5420.2 5451.0 5470.6 2821.0 3005.4 3009.6 3044.5 3087.3 5533.6 5704.8 5880.1 5961.6 6058.7 4709.3 5014.6 5459.5 5865.7 5964.9 5168.5 5600.7 5739.8 6080.5 6117.3 5332.7 5770.5 5779.7 5841.2 5875.2 4773.7 5629.5 5796.6 5809.6 5826.8 5186.0 5746.5 5979.6 6042.8 6120.6 3979.2 4041.5 4047.5 4048.5 4075.7 5400.9 5762.4 5782.6 5824.7 5834.8 4834.6 5181.9 5581.3 5643.7 5664.3 5587.3 5601.2 5605.2 5606.0 5718.4 5060.8 5284.6 5361.3 5470.2 5539.2 5261.6 5606.9 5688.2 5691.5 5700.5 5202.8 5498.5 5578.7 5581.6 5599.8 03:08:05 INFO - PROCESS | 1960 | 03:08:05 INFO - PROCESS | 1960 | [#5] yui.html Cycles:180 Average:24684.18 Median:12893.72 stddev:39900.59 (309.5%) stddev-sans-first:39971.94 03:08:05 INFO - PROCESS | 1960 | Values: 716.3 741.5 753.4 798.1 832.0 13789.5 15614.8 15686.9 15723.8 15741.6 13749.7 14011.6 14033.6 14048.2 14131.4 842.7 850.4 860.4 866.2 866.5 668.0 676.8 697.7 856.7 859.6 903.6 910.9 912.4 912.5 914.9 889.5 905.0 905.2 906.1 907.7 662.2 676.5 677.1 679.4 680.0 15379.2 15521.8 15538.0 15562.7 15572.1 14549.7 14551.9 14557.7 14822.3 14839.3 11611.9 11880.6 11972.7 11984.8 12411.3 3805.8 3814.9 3831.6 3849.1 3863.1 102796.0 105599.5 105828.5 115870.0 120570.0 10938.3 11021.4 11044.2 11081.7 11152.3 21886.3 22110.6 22113.3 22155.0 22179.2 8080.5 8185.7 8191.0 8256.2 8391.5 4389.0 4423.2 4517.7 4550.7 4571.1 3608.2 3696.6 3705.6 3729.3 3765.8 672.4 680.7 685.8 687.6 691.5 538.1 582.8 637.3 641.8 681.7 9335.9 9511.0 9546.0 9851.0 9980.5 621.5 649.5 668.0 694.1 694.4 3815.7 4140.0 4510.4 4587.7 4720.9 83251.0 107246.0 120493.0 163110.0 164162.2 97229.5 139888.1 142680.0 142760.3 146823.0 120089.0 120625.0 120989.0 122295.0 124000.0 9012.9 9228.2 9231.2 9238.8 9251.9 49573.5 53907.0 64759.0 67341.7 67855.3 78978.6 98964.5 102075.5 105561.0 105564.5 11745.5 11762.4 11857.5 11996.2 12499.1 11402.3 12629.6 13124.0 13185.8 13263.5 11202.4 11517.2 11888.3 11944.0 12203.9 10240.3 10625.7 12253.0 12546.8 12832.0 11859.2 11873.9 12221.6 12234.4 12714.7 10154.8 10410.0 10682.9 10893.3 10903.3 10417.7 10659.9 10700.4 10711.3 10794.9 03:08:05 INFO - PROCESS | 1960 | -------- Summary: end -------- 03:08:05 INFO - PROCESS | 1960 | 03:08:06 INFO - TEST-INFO | 1960: exit 0 03:08:06 INFO - TEST-OK | dromaeo_css | took 1113431ms 03:08:06 INFO - TEST-START | kraken 03:08:06 INFO - operating with platform_type : mac_ 03:08:06 INFO - Initialising browser for kraken test... 03:08:06 INFO - TEST-INFO | started process 2030 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmp9hSnle/profile http://localhost:52674/getInfo.html) 03:08:08 INFO - PROCESS | 2030 | __metrics Screen width/height:1600/1200 03:08:08 INFO - PROCESS | 2030 | colorDepth:24 03:08:08 INFO - PROCESS | 2030 | Browser inner width/height: 1024/689 03:08:08 INFO - PROCESS | 2030 | __metrics 03:08:09 ERROR - PROCESS | 2030 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:08:09 INFO - TEST-INFO | 2030: exit 0 03:08:09 INFO - Browser initialized. 03:08:09 INFO - Running cycle 1/1 for kraken test... 03:08:09 INFO - TEST-INFO | started process 2033 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmp9hSnle/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:21 INFO - PROCESS | 2033 | RSS: Main: 224845824 03:08:21 INFO - PROCESS | 2033 | 03:08:24 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:25 INFO - PROCESS | 2033 | RSS: Main: 237518848 03:08:25 INFO - PROCESS | 2033 | 03:08:28 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-dft) 03:08:28 INFO - PROCESS | 2033 | RSS: Main: 245870592 03:08:28 INFO - PROCESS | 2033 | 03:08:32 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-fft) 03:08:33 INFO - PROCESS | 2033 | RSS: Main: 247234560 03:08:33 INFO - PROCESS | 2033 | 03:08:35 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-oscillator) 03:08:35 INFO - PROCESS | 2033 | RSS: Main: 249917440 03:08:35 INFO - PROCESS | 2033 | 03:08:37 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:38 INFO - PROCESS | 2033 | RSS: Main: 250249216 03:08:38 INFO - PROCESS | 2033 | 03:08:41 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52674/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:41 INFO - PROCESS | 2033 | RSS: Main: 250769408 03:08:41 INFO - PROCESS | 2033 | 03:08:44 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52674/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:45 INFO - PROCESS | 2033 | RSS: Main: 250830848 03:08:45 INFO - PROCESS | 2033 | 03:08:48 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52674/tests/kraken/driver.html?testName=json-parse-financial) 03:08:48 INFO - PROCESS | 2033 | RSS: Main: 251121664 03:08:48 INFO - PROCESS | 2033 | 03:08:50 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:51 INFO - PROCESS | 2033 | RSS: Main: 250949632 03:08:51 INFO - PROCESS | 2033 | 03:08:52 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:53 INFO - PROCESS | 2033 | RSS: Main: 251064320 03:08:53 INFO - PROCESS | 2033 | 03:08:55 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:56 INFO - PROCESS | 2033 | RSS: Main: 250970112 03:08:56 INFO - PROCESS | 2033 | 03:08:59 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:09:00 INFO - PROCESS | 2033 | RSS: Main: 251236352 03:09:00 INFO - PROCESS | 2033 | 03:09:02 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:03 INFO - PROCESS | 2033 | RSS: Main: 251265024 03:09:03 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52674/tests/kraken/driver.html?testName=ai-astar) 03:09:05 INFO - PROCESS | 2033 | RSS: Main: 253054976 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | __start_tp_report 03:09:05 INFO - PROCESS | 2033 | _x_x_mozilla_page_load 03:09:05 INFO - PROCESS | 2033 | _x_x_mozilla_page_load_details 03:09:05 INFO - PROCESS | 2033 | |i|pagename|runs| 03:09:05 INFO - PROCESS | 2033 | |0;ai-astar;107;120;118;117;117;118;123;165;116;115 03:09:05 INFO - PROCESS | 2033 | |1;audio-beat-detection;170;113;111;142;134;134;138;112;139;111 03:09:05 INFO - PROCESS | 2033 | |2;audio-dft;271;281;193;214;197;200;205;247;207;196 03:09:05 INFO - PROCESS | 2033 | |3;audio-fft;73;64;52;88;67;81;79;51;91;78 03:09:05 INFO - PROCESS | 2033 | |4;audio-oscillator;88;71;83;71;70;71;90;69;72;87 03:09:05 INFO - PROCESS | 2033 | |5;imaging-gaussian-blur;117;103;88;93;89;84;90;87;88;87 03:09:05 INFO - PROCESS | 2033 | |6;imaging-darkroom;96;95;96;95;97;95;96;96;95;96 03:09:05 INFO - PROCESS | 2033 | |7;imaging-desaturate;131;95;150;96;145;148;111;92;94;92 03:09:05 INFO - PROCESS | 2033 | |8;json-parse-financial;57;56;55;55;58;60;58;59;59;52 03:09:05 INFO - PROCESS | 2033 | |9;json-stringify-tinderbox;69;70;78;74;74;70;69;73;89;70 03:09:05 INFO - PROCESS | 2033 | |10;stanford-crypto-aes;85;84;84;83;77;96;103;85;84;84 03:09:05 INFO - PROCESS | 2033 | |11;stanford-crypto-ccm;126;141;148;149;170;151;155;152;156;151 03:09:05 INFO - PROCESS | 2033 | |12;stanford-crypto-pbkdf2;202;172;171;164;169;170;166;170;164;168 03:09:05 INFO - PROCESS | 2033 | |13;stanford-crypto-sha256-iterative;67;66;69;67;70;66;69;66;68;67 03:09:05 INFO - PROCESS | 2033 | __end_tp_report 03:09:05 INFO - PROCESS | 2033 | __start_cc_report 03:09:05 INFO - PROCESS | 2033 | _x_x_mozilla_cycle_collect,937 03:09:05 INFO - PROCESS | 2033 | __end_cc_report 03:09:05 INFO - PROCESS | 2033 | __startTimestamp1477217345489__endTimestamp 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | ------- Summary: start ------- 03:09:05 INFO - PROCESS | 2033 | Number of tests: 14 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#0] ai-astar Cycles:10 Average:121.60 Median:118.00 stddev:15.79 (13.4%) stddev-sans-first:15.84 03:09:05 INFO - PROCESS | 2033 | Values: 107.0 120.0 118.0 117.0 117.0 118.0 123.0 165.0 116.0 115.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:136.00 stddev:19.02 (14.0%) stddev-sans-first:13.75 03:09:05 INFO - PROCESS | 2033 | Values: 170.0 113.0 111.0 142.0 134.0 134.0 138.0 112.0 139.0 111.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#2] audio-dft Cycles:10 Average:221.10 Median:210.50 stddev:32.83 (15.6%) stddev-sans-first:29.45 03:09:05 INFO - PROCESS | 2033 | Values: 271.0 281.0 193.0 214.0 197.0 200.0 205.0 247.0 207.0 196.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#3] audio-fft Cycles:10 Average:72.40 Median:78.50 stddev:13.79 (17.6%) stddev-sans-first:14.63 03:09:05 INFO - PROCESS | 2033 | Values: 73.0 64.0 52.0 88.0 67.0 81.0 79.0 51.0 91.0 78.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.50 stddev:8.64 (11.1%) stddev-sans-first:8.23 03:09:05 INFO - PROCESS | 2033 | Values: 88.0 71.0 83.0 71.0 70.0 71.0 90.0 69.0 72.0 87.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#5] imaging-gaussian-blur Cycles:10 Average:92.60 Median:88.00 stddev:10.01 (11.4%) stddev-sans-first:5.49 03:09:05 INFO - PROCESS | 2033 | Values: 117.0 103.0 88.0 93.0 89.0 84.0 90.0 87.0 88.0 87.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:09:05 INFO - PROCESS | 2033 | Values: 96.0 95.0 96.0 95.0 97.0 95.0 96.0 96.0 95.0 96.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#7] imaging-desaturate Cycles:10 Average:115.40 Median:92.00 stddev:25.26 (27.5%) stddev-sans-first:26.16 03:09:05 INFO - PROCESS | 2033 | Values: 131.0 95.0 150.0 96.0 145.0 148.0 111.0 92.0 94.0 92.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:58.00 stddev:2.42 (4.2%) stddev-sans-first:2.57 03:09:05 INFO - PROCESS | 2033 | Values: 57.0 56.0 55.0 55.0 58.0 60.0 58.0 59.0 59.0 52.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:73.50 stddev:6.13 (8.3%) stddev-sans-first:6.27 03:09:05 INFO - PROCESS | 2033 | Values: 69.0 70.0 78.0 74.0 74.0 70.0 69.0 73.0 89.0 70.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:84.00 stddev:7.41 (8.8%) stddev-sans-first:7.84 03:09:05 INFO - PROCESS | 2033 | Values: 85.0 84.0 84.0 83.0 77.0 96.0 103.0 85.0 84.0 84.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:151.50 stddev:11.20 (7.4%) stddev-sans-first:7.86 03:09:05 INFO - PROCESS | 2033 | Values: 126.0 141.0 148.0 149.0 170.0 151.0 155.0 152.0 156.0 151.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:170.00 stddev:11.04 (6.5%) stddev-sans-first:2.95 03:09:05 INFO - PROCESS | 2033 | Values: 202.0 172.0 171.0 164.0 169.0 170.0 166.0 170.0 164.0 168.0 03:09:05 INFO - PROCESS | 2033 | 03:09:05 INFO - PROCESS | 2033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.43 (2.1%) stddev-sans-first:1.51 03:09:05 INFO - PROCESS | 2033 | Values: 67.0 66.0 69.0 67.0 70.0 66.0 69.0 66.0 68.0 67.0 03:09:05 INFO - PROCESS | 2033 | -------- Summary: end -------- 03:09:05 INFO - PROCESS | 2033 | 03:09:06 INFO - TEST-INFO | 2033: exit 0 03:09:06 INFO - TEST-OK | kraken | took 60138ms 03:09:06 INFO - SUITE-END | took 1173s 03:09:06 INFO - Completed test suite (00:19:33) 03:09:06 INFO - javascript benchmark 03:09:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7257.490240684546, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.764186506945, 3378.7465940054485, 3382.5602671652664, 3405.0976491229844, 3439.810810405428, 5602.719864006799, 5643.943560564393, 5685.602007859441, 5687.289088863892, 5705.429457054298, 5032.993401319733, 5408.134698448249, 5625.5499560035205, 5654.773809047633, 5682.431756824316, 5189.688618682872, 5224.764885580158, 5233.476652334755, 5284.2602035714835, 5289.20661900716, 5235.842924712265, 5256.211568264772, 5258.973705131469, 5275.736213189344, 5296.25852380667, 5163.225516172567, 5188.455212202721, 5270.2358158067245, 5281.339832520935, 5327.573794096463, 4452.755098469583, 5220.686758794484, 5241.344831896013, 5284.154535274338, 5320.0, 5107.668001579886, 5214.6871187728475, 5217.113090774577, 5217.2695822584865, 5316.20256961455, 5053.898922021539, 5437.9939711153165, 5700.344460387067, 5753.510951569122, 5801.593888427812, 6103.786367477162, 6106.145139680449, 6109.799438327934, 6116.792316687807, 6188.071789231606, 4855.902881942341, 5334.279872217278, 6245.344238854946, 6283.403076707706, 6302.779402720883, 4888.511148885119, 5779.422057794271, 5791.218185544982, 5794.21778059965, 5809.0, 5527.226188333637, 6079.331273559905, 6237.96881015592, 6247.718852651642, 6262.12330273762, 5978.0733986231335, 6119.908201376983, 6124.693765311717, 6125.632462052291, 6164.951958167122, 5157.94262176253, 5213.921791173136, 6258.342873998165, 6274.560780745395, 6280.874382512324, 5624.29696287964, 6012.549058820518, 6077.848053798691, 6110.224634763396, 6134.957077260912, 6101.60339577926, 6130.969345153246, 6142.477889379364, 6149.723262453201, 6155.35368786271, 4225.81677130404, 4575.22221222393, 4831.106245344622, 4861.611071114302, 4882.5605695486865, 4302.548232435612, 4314.41755363022, 4319.33050377192, 4319.935200971988, 4387.780610969438, 5782.826515204551, 5800.506956908625, 5844.9415505845245, 5875.794347197828, 5898.705064746746, 5367.194920761917, 6141.723622437001, 6269.373062693785, 6280.214973128359, 6286.49708023357, 5671.347795003545, 5712.514436272881, 5795.956727788954, 5829.125631155276, 5838.4453476919625, 5419.430959749248, 5420.403755586961, 5420.674759514442, 5430.538404235605, 5437.0, 6293.433590976834, 6304.590201636879, 6309.589876658002, 6313.55805093639, 6332.556721029576, 6126.181801871033, 6170.259568851767, 6196.411340922786, 6266.310705822447, 6286.528510361833, 6239.719212635351, 6277.30949595535, 6296.622202667854, 6304.401081897213, 6344.080108384351, 6171.321154673072, 6186.505079593711, 6191.288001879841, 6199.535034872493, 6238.500919926304, 6143.1706719592285, 6143.972489078504, 6150.630962142286, 6276.403741644536, 6292.937070629235, 4966.758310422394, 6023.247094113236, 6035.818925432244, 6087.604305720114, 6125.877482450415, 6063.575549711654, 6066.393360663898, 6077.878442431038, 6082.847928801639, 6103.816885493442, 5779.335376431596, 5784.768609255582, 5908.675022873783, 5970.820875373745, 5979.5814292999075, 4931.827386041471, 6003.729832157476, 6023.337432882292, 6044.879102418015, 6111.561351782648, 4853.417589889236, 5005.074061298671, 5870.853228669317, 5897.587168898136, 5926.674032928058], "value": 5607.137296484608, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.81844443778056, 464.9116667833112, 480.5194805194806, 511.8131881863119, 551.2117671729426, 39561.2087758245, 41422.17155656885, 41506.16987660245, 41549.3767593486, 41627.16745665089, 42975.35536966948, 43235.35146972798, 43372.783136084356, 43374.56625433745, 43495.0, 9693.0, 9860.35907666003, 9881.901180988207, 9910.306278560503, 9964.750881227956, 9806.607735690564, 9809.558569864337, 9818.803623927517, 9863.112319891208, 9875.1112399884, 9867.0, 9912.603495860158, 9919.50402479873, 9921.107100360967, 9923.305368624198, 9836.06557377048, 9883.01169883013, 9885.258605604537, 9905.108540231342, 9914.9504252479, 8677.479351238946, 9787.608495660164, 9886.703398898044, 9892.505374731234, 9903.207743380512, 40305.79847100775, 40560.79719601413, 40743.7962810187, 40915.59084409148, 40996.0, 3336.916577085568, 3456.9827150864335, 3461.6538346165435, 3465.8440370183403, 3467.2025434150037, 30129.698703013128, 30751.538726919112, 30792.538111928337, 30806.84596577025, 31095.378092438026, 3126.5622812806228, 3254.332861763333, 3256.3161736035463, 3262.0, 3271.7382609391193, 529090.0, 535658.0, 536632.0, 539362.0, 539538.0, 32986.17534561655, 62694.68652656708, 62719.43201420001, 63234.0, 63492.365076348644, 33764.49353259703, 34230.65769342275, 34762.65237347645, 35067.64932350644, 35160.82419587886, 14515.782263266059, 14637.487687931085, 14853.851461485247, 14920.70158596822, 15060.0, 12439.315837629018, 12706.936465317614, 12830.67923301925, 12885.355732213351, 12902.903253223394, 7718.961405192938, 7722.11195712489, 7777.377809775205, 7799.259070388304, 7802.609869506502, 3234.1267857678768, 3272.7054565089256, 3281.0, 3285.3265080658407, 3287.967120328814, 921.424109931293, 967.3035414501547, 973.8636590877283, 988.9357191782511, 1010.7321559786662, 27071.91712331524, 30672.53991190134, 30984.0704778857, 31622.209444764067, 32759.18102047468, 1073.656429942411, 1080.6757972608343, 1095.5782023920688, 1164.7845148647527, 1168.8772678868766, 15056.247187640793, 15140.848591514165, 15184.924075379773, 15242.618934526725, 15475.071495710068, 677649.0, 693514.0, 695721.0, 696617.0, 697899.0, 52900.0, 53358.46641533612, 53377.73311133419, 53465.930681386155, 53630.73184634052, 1336.4587342126454, 1367.8768910797876, 1375.4154484344115, 1383.8339399272152, 1387.278615120132, 28405.147845564665, 28959.0, 29030.7096929028, 29579.704202957695, 29585.704142959155, 39781.00547486336, 48555.0, 49094.509054908995, 49203.50796492132, 49210.75394623004, 601272.0, 646896.5310346836, 665061.0, 666170.0, 667184.0, 23010.539789203787, 25210.74789252084, 25358.873205633852, 26558.0, 27248.318792030357, 46479.535204647524, 46588.53411465978, 46589.76705116453, 46671.76664116658, 47729.045419090726, 31456.685433146293, 33782.83108584442, 37871.0, 38520.422193666556, 38676.90584753269, 30485.0, 37349.0, 37779.244415110996, 37905.0, 38248.235035299695, 31978.84010579932, 32528.349433010735, 36502.45246321254, 37953.0, 39002.804985974886, 25663.0, 27623.58564621492, 33785.83107084449, 33841.49237761485, 35717.82141089278, 25443.36391590225, 25503.0, 25561.23316300514, 25660.615090774027, 26063.045271604326], "value": 18670.463765364744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9795411252382, 375.51558489548484, 379.84616230426667, 385.60668118519095, 397.59246772058634, 18717.0, 19298.74558153719, 21414.0, 21776.0, 22030.559388812213, 21106.788932110674, 21165.788342116575, 21369.14523419065, 21519.784802151975, 21668.674969875425, 5904.97047514764, 5923.466887980092, 6119.724612392453, 6202.3487533808975, 6217.471514921237, 4205.2851015327315, 4441.511433742286, 6097.451229389354, 6116.938830611703, 6372.776952806653, 6584.802455926306, 6588.044733513638, 6618.0, 6706.39642432181, 6723.731050757989, 6455.548111632188, 6672.132622759059, 6719.193696756421, 6722.697478613474, 6726.529142959995, 5794.101914203306, 5794.739236734357, 5806.0, 5843.211166492554, 5850.795222167204, 23971.400714982265, 24288.878555607287, 24296.149634762874, 24351.391215219584, 24374.39064023396, 2098.3600001999384, 2422.7577242275806, 2908.7382135607895, 3111.828849413281, 3125.890593829228, 10202.846957295647, 10207.234457415649, 10215.846762298572, 10397.896021039769, 10510.684679459628, 1854.6754317994432, 1867.7758668959675, 1875.9062046897736, 1910.2836436336374, 1961.9509512262166, 132371.0, 135807.0, 138189.0, 139616.30191849076, 141380.0, 9335.533223338805, 9934.552945117486, 9975.551100200508, 9987.900120998842, 10159.9492002541, 12553.748925021448, 12563.0, 12606.306653134166, 12665.683357916127, 12667.303298318497, 8098.919010809935, 8231.95884020588, 8236.752897413087, 8262.256396924306, 8313.836062951192, 8636.438631488933, 8728.214460698568, 8764.0, 8850.734477965543, 8878.51168185756, 3818.1981783825154, 3834.616538346143, 3947.348687466593, 3967.0677390813134, 3972.7616343019513, 1596.7525033619806, 1646.2180464279372, 1679.3534489221493, 1937.205745644279, 1991.5817678287722, 763.343544508407, 845.2984023260678, 860.2601762484259, 1024.8052869954834, 1032.2258306270298, 20753.58492830135, 21438.78561214399, 21570.0, 21646.78353216479, 21896.45258868541, 896.6278994217326, 929.1776777551916, 941.6704153546341, 952.6332362040525, 1000.1198944928417, 10027.04743049409, 10634.564333814991, 11299.423802900952, 11371.090312774959, 11443.713907152222, 611412.0, 626924.0, 631910.0, 633487.0, 637137.0, 131995.0, 134897.0, 136207.63792362149, 137642.0, 138135.30932345273, 921.4609453469661, 951.0869565217331, 970.0, 973.7176218896583, 974.0503009565617, 15504.0, 18426.81573184251, 18661.533461663566, 18719.532011699815, 18969.33607323737, 35036.824815875756, 36596.81701591475, 53462.73268633632, 53512.73243633757, 55791.44208557862, 58439.831203374844, 73119.26880731125, 76657.1671416438, 79920.0, 84192.57903710443, 7090.184628767758, 7255.455840811855, 7444.404447644284, 7514.774556763306, 7529.096508419025, 9346.345755797029, 9582.90417095848, 11031.503582338653, 12973.481060757464, 13058.477660893837, 11120.165987551129, 11154.721131971766, 11428.71428214268, 11442.82835757481, 11795.882041179822, 11223.943880280547, 11258.605948791754, 11482.081433485135, 11498.367589782642, 11636.883631163919, 11412.372319522174, 11578.36319002463, 11717.824232636347, 11905.523779049088, 11955.0, 7116.288371162842, 7471.925280747123, 7499.775006749806, 8276.337892968668, 8339.0, 8219.178082191733, 10430.791384172426, 11464.4267786612, 11706.88293117058, 11771.646850594496], "value": 9523.616741936241, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.5387560669599, 1576.156756135467, 1584.1762283612522, 1761.8547943836513, 1879.7650293713286, 7790.532568045915, 8117.431779775403, 8401.66393344267, 9090.181883630481, 9125.726228213156, 8534.957325213365, 8857.11428857114, 8890.244329232022, 8963.641454341818, 8988.191062804346, 2401.6997875265633, 2439.377958620549, 2442.5969714997004, 2445.461998360358, 2447.339218411028, 2407.9157229496973, 2412.300432874464, 2428.453597940467, 2438.426969662128, 2450.6324051392257, 2422.2491027781357, 2428.7449817769143, 2433.4889673168655, 2443.621238708003, 2449.4243852694603, 2391.820613453989, 2399.6400539918977, 2406.855588664677, 2417.395651087228, 2420.3465064432503, 2396.7363590005084, 2408.7952524035477, 2408.9397765056015, 2410.421498840283, 2416.347586151747, 9049.683261085896, 9064.864027039599, 9128.45229286245, 9132.99537050924, 9142.405743626643, 5238.502342277516, 5307.991481618519, 5312.601554883399, 5349.812756553541, 5405.891882162374, 3578.6063533011347, 3686.7234957378305, 3721.0139313081786, 3728.2543491301576, 3751.9437208441623, 1077.1974878715407, 1097.6432659385653, 1107.9169062320277, 1127.6222465474077, 1128.8983991440728, 10790.78418431627, 11050.502727377287, 11820.23168494045, 11977.820332695017, 12016.339101349422, 4246.787660616957, 4625.398698169284, 4727.558094781125, 4743.8794174320665, 4901.681390709664, 9950.552225149886, 10040.0, 10106.292559520763, 10142.594296228215, 10156.289059765893, 4257.638100761408, 4603.930941035887, 5184.429712731597, 5395.730213489388, 5407.188921661704, 3953.644172024474, 4335.631471324973, 4485.842995495142, 4770.76146192689, 4924.704517728947, 3995.2808494471274, 3995.300822356076, 4040.939385909214, 4079.1841631673783, 4092.2224777292217, 1273.9681507962375, 1279.405076639367, 1303.7262174943369, 1314.5530519623373, 1327.8273824402766, 769.7228997560874, 875.1292463998235, 914.2640174659463, 916.1800188831093, 932.6362718539775, 5908.438698323653, 5932.228810254725, 5955.612885162451, 6096.780643871243, 6147.538934579835, 861.0571424290392, 915.4736026784625, 947.625687853294, 979.1236843025453, 988.9505524723735, 3941.2117576484816, 4075.470188875427, 4088.0801819590947, 4119.114390406077, 4167.854125105607, 9407.623695052258, 10715.946420267848, 11063.170262230204, 11091.057260132819, 11127.72180695489, 10362.171026317876, 10807.513661885234, 10828.512716927757, 11042.723931901606, 11043.171762117874, 8242.052164001097, 8431.789205269917, 8489.745307640904, 8490.957545212234, 8514.361422893307, 6028.8794224116145, 6094.329623741296, 6109.6639684817765, 6120.326764056039, 6213.1922850029205, 9953.303268771117, 10224.693259202237, 10302.896971030494, 10407.895921040692, 10456.63401780934, 9494.810103798023, 10202.846957295795, 10312.071913527818, 10369.74075648115, 10631.308964917256, 7045.788626341218, 7235.384992275715, 7449.292317229854, 7637.541747495168, 7697.46117771773, 8428.704995325133, 8450.788730281793, 8588.012378576293, 8588.441751286146, 8624.913750862412, 7527.6988920444755, 7584.962075189809, 7666.846663066819, 7753.844923101619, 7793.220677932161, 7461.179270280373, 7471.626418679153, 7491.43814213947, 7590.848183036419, 7652.273034061755, 6952.478564107813, 7082.964585177041, 7095.3968912643, 7095.722769901261, 7097.219305876246, 4973.3144102184415, 5035.949640503548, 5144.6398752087, 5195.402528709247, 5240.2663627093, 4812.735299558558, 4935.605151587936, 5043.4956504349275, 5050.444451110448, 5111.718855462986], "value": 4654.453406906003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.3623581770829, 308.4540363556505, 308.577249168639, 308.76071044940153, 309.66710785905144, 5070.898582028357, 5229.111051121309, 5342.278792363029, 5393.191021346795, 5398.6490878092945, 4376.168527979682, 4414.139242847646, 4663.930041049387, 5036.597072234222, 5189.247559103937, 3636.3272794532963, 3840.558335791378, 3896.961030389688, 4048.817803198863, 4071.837126514951, 3192.569003184575, 3388.966110338902, 3449.9827500862584, 3698.5746639136573, 3937.798971313748, 3365.444701624229, 4007.6593489553425, 4033.1328764315813, 4048.0, 4069.572694867041, 3459.564280823455, 3539.4159963605975, 3918.1380096378753, 4071.534247670836, 4083.448734420845, 2962.348283377675, 3147.733631785111, 3526.994806480141, 3555.1823080691584, 3575.0, 4947.678400903966, 5087.79648814047, 5094.286799848024, 5130.615203859688, 5164.406093299243, 4608.018552022629, 4615.83844565442, 4628.3288923105965, 4630.050839577879, 4644.724085198262, 4913.950860491421, 5325.7869685212545, 5531.778728850841, 5532.17858891968, 5614.494695477427, 3529.5235143255845, 3765.1340191755776, 3881.262560113598, 3882.2041481496226, 3889.9416508752392, 5387.434319396446, 5830.183774271605, 5859.589828711992, 5904.439078287556, 5927.0, 3158.57359256502, 3623.836927338276, 3695.519582454264, 3855.325318069327, 3865.3958607177706, 3798.677112445473, 3927.842886284574, 3932.4297976793205, 3932.744371615836, 3942.526896772348, 4155.449782488171, 4164.58404142593, 4522.3668686383935, 4533.84131555394, 4537.931931021038, 4745.667803253739, 5676.956295733533, 5696.20253164549, 5704.832163777738, 5712.971435142797, 1261.6593519749615, 1295.4105881823937, 1302.9543965961336, 1325.0592079623575, 1335.6861137632648, 836.6736972580699, 876.548577482597, 877.6840337478502, 893.3300024981264, 903.5572569441058, 4579.855231015936, 4972.602191824645, 5231.848993221485, 5323.121684922022, 5325.760340784674, 4574.405327307429, 5092.032513822362, 5726.310738332202, 5735.942640573541, 5752.935706894238, 5162.070827251131, 5165.586753059746, 5420.159875219348, 5451.0, 5470.64440811346, 2820.971790282112, 3005.443992861328, 3009.6087508623737, 3044.528098144791, 3087.2899233176045, 5533.557315414757, 5704.80033198836, 5880.066186878245, 5961.5826892118, 6058.727357268934, 4709.270063140219, 5014.598832093424, 5459.481349271813, 5865.715199488301, 5964.850878728066, 5168.457311982188, 5600.691961942132, 5739.823336215982, 6080.483158931452, 6117.265928088569, 5332.653632401731, 5770.538356931352, 5779.739911704068, 5841.240638716939, 5875.20684707559, 4773.663374255214, 5629.4652008059165, 5796.594238403271, 5809.593328466966, 5826.82519524415, 5185.9887321971855, 5746.540276777764, 5979.641221526722, 6042.84892877664, 6120.571559990758, 3979.184267225154, 4041.454403655469, 4047.534533528564, 4048.473698419187, 4075.694322925852, 5400.8649783754145, 5762.423757624204, 5782.595218334676, 5824.650520968756, 5834.795782147605, 4834.6374021947795, 5181.870453238699, 5581.274434323512, 5643.746031428677, 5664.348599911063, 5587.329520457572, 5601.187827765033, 5605.215269862304, 5606.0, 5718.370979192368, 5060.822871199491, 5284.630075894805, 5361.337985224593, 5470.206820010996, 5539.224508568885, 5261.553377679397, 5606.887862242651, 5688.203651488878, 5691.544676425959, 5700.546360678167, 5202.803355228394, 5498.477644623755, 5578.721063946705, 5581.553475722014, 5599.80400685974], "value": 4080.737398963231, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.2980279326264, 741.5328343143818, 753.4178225725976, 798.1140933563745, 831.9875201871973, 13789.517366892149, 15614.843851561482, 15686.921565392156, 15723.764143537855, 15741.60645983851, 13749.65625859354, 14011.579652610413, 14033.649158771035, 14048.157110573373, 14131.434742610309, 842.7387509871944, 850.4344610833818, 860.3547339495378, 866.2420382165606, 866.5320726807548, 667.9699413526379, 676.7901950395393, 697.6616341074575, 856.7130011446142, 859.6088779605265, 903.6430609909082, 910.9362344635845, 912.3932584831113, 912.5346073502495, 914.9130832570895, 889.488544087146, 904.9819003619924, 905.1717678324326, 906.0531744327128, 907.7367563406605, 662.1822049768532, 676.509530590323, 677.1298880937971, 679.3817625960353, 680.0105845994116, 15379.154146521936, 15521.767173492406, 15538.0, 15562.688746225012, 15572.143532105729, 14549.70900581993, 14551.927240363837, 14557.708845823025, 14822.258887055605, 14839.258037098101, 11611.883881161164, 11880.584179553674, 11972.70068248292, 11984.760304793943, 12411.255324680547, 3805.847766089353, 3814.8855534334016, 3831.578526362098, 3849.076221706798, 3863.111484358585, 102795.97204028013, 105599.4720026395, 105828.470857646, 115870.0, 120570.0, 10938.289011214245, 11021.393823339793, 11044.171687123498, 11081.667549973514, 11152.275102118336, 21886.343409697416, 22110.557788844133, 22113.336599902028, 22155.0, 22179.223727169472, 8080.515169089874, 8185.672573097009, 8191.0, 8256.234161555825, 8391.496510209407, 4388.9935394255035, 4423.203823311835, 4517.706349087364, 4550.726956382561, 4571.085782843445, 3608.224231790178, 3696.5748938871834, 3705.555333360014, 3729.328720830277, 3765.811709414518, 672.364615438406, 680.7311112110689, 685.8148299959083, 687.6046273392819, 691.5263044814318, 538.0691403871325, 582.8426324892255, 637.2671427858, 641.7561326695919, 681.7409384433884, 9335.859962100438, 9511.0, 9546.0, 9851.0, 9980.45107519079, 621.5307442880596, 649.4771708774388, 668.0293135251029, 694.1496666583496, 694.4062826283556, 3815.6565909068318, 4140.0, 4510.391097201901, 4587.7017993830295, 4720.905581888343, 83251.0, 107246.0, 120493.0, 163110.0, 164162.1791891057, 97229.51385243029, 139888.10391636446, 142680.0, 142760.28619857042, 146823.0, 120089.0, 120625.0, 120988.99999999824, 122295.0, 124000.0, 9012.909870901469, 9228.215601673934, 9231.215346695606, 9238.815223695354, 9251.907480925374, 49573.504264956886, 53907.0, 64759.0, 67341.66329168323, 67855.3214467849, 78978.6051069741, 98964.50517747653, 102075.48962255141, 105561.0, 105564.47217763861, 11745.530178793095, 11762.3530705812, 11857.525698971944, 11996.220245684002, 12499.125061245626, 11402.315861048364, 12629.621111366674, 13124.0, 13185.802212967004, 13263.535776247785, 11202.38386888729, 11517.193796434169, 11888.286702797513, 11944.0, 12203.938980305042, 10240.283180177315, 10625.734356641145, 12253.019758419483, 12546.811797822857, 12832.037597180062, 11859.22915010556, 11873.940630296793, 12221.572244971383, 12234.449449774604, 12714.745705086032, 10154.847677284699, 10410.0, 10682.946585267024, 10893.346399216072, 10903.34579925207, 10417.687469375627, 10659.934006599588, 10700.41147736882, 10711.303765255234, 10794.946025269823], "value": 7715.604209428371, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 118.0, 117.0, 117.0, 118.0, 123.0, 165.0, 116.0, 115.0], "value": 121.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 113.0, 111.0, 142.0, 134.0, 134.0, 138.0, 112.0, 139.0, 111.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [271.0, 281.0, 193.0, 214.0, 197.0, 200.0, 205.0, 247.0, 207.0, 196.0], "value": 221.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 64.0, 52.0, 88.0, 67.0, 81.0, 79.0, 51.0, 91.0, 78.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 83.0, 71.0, 70.0, 71.0, 90.0, 69.0, 72.0, 87.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 103.0, 88.0, 93.0, 89.0, 84.0, 90.0, 87.0, 88.0, 87.0], "value": 92.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 95.0, 150.0, 96.0, 145.0, 148.0, 111.0, 92.0, 94.0, 92.0], "value": 115.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 55.0, 58.0, 60.0, 58.0, 59.0, 59.0, 52.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 78.0, 74.0, 74.0, 70.0, 69.0, 73.0, 89.0, 70.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 83.0, 77.0, 96.0, 103.0, 85.0, 84.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 141.0, 148.0, 149.0, 170.0, 151.0, 155.0, 152.0, 156.0, 151.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 172.0, 171.0, 164.0, 169.0, 170.0, 166.0, 170.0, 164.0, 168.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 67.0, 70.0, 66.0, 69.0, 66.0, 68.0, 67.0], "value": 67.5, "unit": "score"}]}]} 03:09:06 INFO - Return code: 0 03:09:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:09:06 ERROR - # TBPL SUCCESS # 03:09:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:06 INFO - 2016-10-23 03:09:06.817 screenresolution[2038:25183] starting screenresolution argv=screenresolution get 03:09:06 INFO - 2016-10-23 03:09:06.820 screenresolution[2038:25183] Display 0: 1600x1200x32@60 03:09:06 INFO - 2016-10-23 03:09:06.825 screenresolution[2039:25186] starting screenresolution argv=screenresolution list 03:09:06 INFO - Available Modes on Display 0 03:09:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:07 INFO - Intel Iris: 03:09:07 INFO - Chipset Model: Intel Iris 03:09:07 INFO - Type: GPU 03:09:07 INFO - Bus: Built-In 03:09:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:07 INFO - Vendor: Intel (0x8086) 03:09:07 INFO - Device ID: 0x0a2e 03:09:07 INFO - Revision ID: 0x0009 03:09:07 INFO - Displays: 03:09:07 INFO - Display: 03:09:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:07 INFO - Display Serial Number: 1600x1200 60 03:09:07 INFO - Main Display: Yes 03:09:07 INFO - Mirror: Off 03:09:07 INFO - Online: Yes 03:09:07 INFO - Rotation: Supported 03:09:07 INFO - Return code: 0 03:09:07 INFO - Running post-action listener: _resource_record_post_action 03:09:07 INFO - [mozharness: 2016-10-23 10:09:07.061455Z] Finished run-tests step (success) 03:09:07 INFO - Running post-run listener: _resource_record_post_run 03:09:07 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1413120; Write bytes: 667902464; Read time: 13; Write time: 1978 03:09:07 INFO - TinderboxPrint: CPU usage
54.3% 03:09:07 INFO - TinderboxPrint: I/O read bytes / time
1,413,120 / 13 03:09:07 INFO - TinderboxPrint: I/O write bytes / time
667,902,464 / 1,978 03:09:07 INFO - TinderboxPrint: CPU idle
2,208.4 (45.7%) 03:09:07 INFO - TinderboxPrint: CPU system
978.6 (20.3%) 03:09:07 INFO - TinderboxPrint: CPU user
1,642.8 (34.0%) 03:09:07 INFO - TinderboxPrint: Swap in / out
364,388,352 / 0 03:09:07 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 364239360; Write bytes: 367740928; Read time: 28561; Write time: 783 03:09:07 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 438272; Write bytes: 298818048; Read time: 7; Write time: 1190 03:09:07 INFO - Running post-run listener: _upload_blobber_files 03:09:07 INFO - Blob upload gear active. 03:09:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:09:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:09:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:08 INFO - (blobuploader) - INFO - Done attempting. 03:09:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:09:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:09 INFO - (blobuploader) - INFO - Done attempting. 03:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:11 INFO - (blobuploader) - INFO - Done attempting. 03:09:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:11 INFO - Return code: 0 03:09:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758775515a306b7dcb371b856066e0f73beff073e8a8392874970f170f534351c8588bc2e0e1b52fce673ce170ef867269e21fce43cfeec42e7d403280e2be39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd39dc89b6c20c48dc8392429698d717454653ea5d8412e43f225d72b1759a4724c20eb833932cc99a303ed2723ebff47450b133568ceed9e6a6b7390a8a3b34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a671c40ffb72c1d91ab87c9ab3f17c64b13892b106570ea4adb90d259d24770ca1b830c8a0db6e8cec41d87620bb15d4fcfbb6925ebfc02d71234846c3430b8c"} 03:09:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:11 INFO - Contents: 03:09:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758775515a306b7dcb371b856066e0f73beff073e8a8392874970f170f534351c8588bc2e0e1b52fce673ce170ef867269e21fce43cfeec42e7d403280e2be39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd39dc89b6c20c48dc8392429698d717454653ea5d8412e43f225d72b1759a4724c20eb833932cc99a303ed2723ebff47450b133568ceed9e6a6b7390a8a3b34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a671c40ffb72c1d91ab87c9ab3f17c64b13892b106570ea4adb90d259d24770ca1b830c8a0db6e8cec41d87620bb15d4fcfbb6925ebfc02d71234846c3430b8c"} 03:09:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:11 INFO - Copying logs to upload dir... 03:09:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.356731 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-23 03:09:11.811114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 03:09:11.814806) ========= 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.fA58Zgdkuv/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.oK00lM4Si7/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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/758775515a306b7dcb371b856066e0f73beff073e8a8392874970f170f534351c8588bc2e0e1b52fce673ce170ef867269e21fce43cfeec42e7d403280e2be39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd39dc89b6c20c48dc8392429698d717454653ea5d8412e43f225d72b1759a4724c20eb833932cc99a303ed2723ebff47450b133568ceed9e6a6b7390a8a3b34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a671c40ffb72c1d91ab87c9ab3f17c64b13892b106570ea4adb90d259d24770ca1b830c8a0db6e8cec41d87620bb15d4fcfbb6925ebfc02d71234846c3430b8c"} build_url:https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/A7EpEy7kQ8yfJhya3wfyRw/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/758775515a306b7dcb371b856066e0f73beff073e8a8392874970f170f534351c8588bc2e0e1b52fce673ce170ef867269e21fce43cfeec42e7d403280e2be39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd39dc89b6c20c48dc8392429698d717454653ea5d8412e43f225d72b1759a4724c20eb833932cc99a303ed2723ebff47450b133568ceed9e6a6b7390a8a3b34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a671c40ffb72c1d91ab87c9ab3f17c64b13892b106570ea4adb90d259d24770ca1b830c8a0db6e8cec41d87620bb15d4fcfbb6925ebfc02d71234846c3430b8c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 03:09:11.851294) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 03:09:11.851958) ========= 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.fA58Zgdkuv/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.oK00lM4Si7/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.004678 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 03:09:11.900381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 03:09:11.900729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 03:09:11.901101) ========= ========= Total master_lag: 0.18 =========