builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0137 starttime: 1479475508.34 results: success (0) buildid: 20161118040828 builduid: 1aa1d4ab7c794f94a737edcf8e37d62f revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.337417) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.337956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.338269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.370338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.370807) ========= 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.d09wc38ilG/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.m4a9TPSXUH/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-11-18 05:25:08-- 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% 30.5M=0s 2016-11-18 05:25:08 (30.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129886 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.530261) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.530578) ========= 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.d09wc38ilG/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.m4a9TPSXUH/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.026433 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:08.579081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 05:25:08.582478) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --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-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d09wc38ilG/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.m4a9TPSXUH/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-11-18 05:25:08,677 truncating revision to first 12 chars 2016-11-18 05:25:08,677 Setting DEBUG logging. 2016-11-18 05:25:08,677 attempt 1/10 2016-11-18 05:25:08,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/11b5acda902f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 05:25:10,339 unpacking tar archive at: mozilla-beta-11b5acda902f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.932210 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 05:25:10.540472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:10.540844) ========= script_repo_revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:10.541285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:10.541556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 05:25:10.561378) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-18 05:25:10.561843) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d09wc38ilG/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.m4a9TPSXUH/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:25:10 INFO - MultiFileLogger online at 20161118 05:25:10 in /builds/slave/test 05:25:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:25:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:10 INFO - {'append_to_log': False, 05:25:10 INFO - 'base_work_dir': '/builds/slave/test', 05:25:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:25:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:10 INFO - 'branch': 'Mozilla-Beta', 05:25:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:10 INFO - 'config_files': ('talos/mac_config.py',), 05:25:10 INFO - 'default_actions': ('clobber', 05:25:10 INFO - 'read-buildbot-config', 05:25:10 INFO - 'download-and-extract', 05:25:10 INFO - 'populate-webroot', 05:25:10 INFO - 'create-virtualenv', 05:25:10 INFO - 'install', 05:25:10 INFO - 'run-tests'), 05:25:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:10 INFO - 'download_minidump_stackwalk': True, 05:25:10 INFO - 'download_symbols': 'ondemand', 05:25:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:10 INFO - 'installer_path': 'installer.exe', 05:25:10 INFO - 'log_level': 'info', 05:25:10 INFO - 'log_name': 'talos', 05:25:10 INFO - 'log_to_console': True, 05:25:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:25:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:25:10 INFO - 'opt_config_files': (), 05:25:10 INFO - 'pip_index': False, 05:25:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:10 INFO - 'cmd': ('bash', 05:25:10 INFO - '-c', 05:25:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:10 INFO - 'enabled': True, 05:25:10 INFO - 'halt_on_failure': False, 05:25:10 INFO - 'name': 'check_screen_resolution'},), 05:25:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:10 INFO - 'cmd': ('bash', 05:25:10 INFO - '-c', 05:25:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:10 INFO - 'enabled': True, 05:25:10 INFO - 'halt_on_failure': False, 05:25:10 INFO - 'name': 'check_screen_resolution'},), 05:25:10 INFO - 'run_cmd_checks_enabled': True, 05:25:10 INFO - 'sps_profile': False, 05:25:10 INFO - 'sps_profile_interval': 0, 05:25:10 INFO - 'suite': 'dromaeojs-e10s', 05:25:10 INFO - 'system_bits': '32', 05:25:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:10 INFO - 'title': 't-yosemite-r7-0137', 05:25:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:10 INFO - 'use_talos_json': True, 05:25:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:10 INFO - 'work_dir': 'build'} 05:25:10 INFO - [mozharness: 2016-11-18 13:25:10.761819Z] Running clobber step. 05:25:10 INFO - Running pre-action listener: _resource_record_pre_action 05:25:10 INFO - Running main action method: clobber 05:25:10 INFO - rmtree: /builds/slave/test/build 05:25:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:13 INFO - Running post-action listener: _resource_record_post_action 05:25:13 INFO - [mozharness: 2016-11-18 13:25:13.099816Z] Finished clobber step (success) 05:25:13 INFO - [mozharness: 2016-11-18 13:25:13.099927Z] Running read-buildbot-config step. 05:25:13 INFO - Running pre-action listener: _resource_record_pre_action 05:25:13 INFO - Running main action method: read_buildbot_config 05:25:13 INFO - Using buildbot properties: 05:25:13 INFO - { 05:25:13 INFO - "project": "", 05:25:13 INFO - "product": "firefox", 05:25:13 INFO - "script_repo_revision": "production", 05:25:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 05:25:13 INFO - "repository": "", 05:25:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 05:25:13 INFO - "buildid": "20161118040828", 05:25:13 INFO - "pgo_build": "False", 05:25:13 INFO - "basedir": "/builds/slave/test", 05:25:13 INFO - "buildnumber": 4, 05:25:13 INFO - "slavename": "t-yosemite-r7-0137", 05:25:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:25:13 INFO - "platform": "yosemite_r7", 05:25:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:25:13 INFO - "branch": "mozilla-beta", 05:25:13 INFO - "repo_path": "releases/mozilla-beta", 05:25:13 INFO - "revision": "11b5acda902f5ecb13ab2d451d36c7a9063f2b26", 05:25:13 INFO - "stage_platform": "macosx64", 05:25:13 INFO - "builduid": "1aa1d4ab7c794f94a737edcf8e37d62f", 05:25:13 INFO - "slavebuilddir": "test" 05:25:13 INFO - } 05:25:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 05:25:13 INFO - Running post-action listener: _resource_record_post_action 05:25:13 INFO - [mozharness: 2016-11-18 13:25:13.103297Z] Finished read-buildbot-config step (success) 05:25:13 INFO - [mozharness: 2016-11-18 13:25:13.103430Z] Running download-and-extract step. 05:25:13 INFO - Running pre-action listener: _resource_record_pre_action 05:25:13 INFO - Running main action method: download_and_extract 05:25:13 INFO - mkdir: /builds/slave/test/build/tests 05:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:13 INFO - trying https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 05:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 05:25:14 INFO - Downloaded 1165 bytes. 05:25:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:25:14 INFO - Using the following test package requirements: 05:25:14 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:25:14 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:25:14 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 05:25:14 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:25:14 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 05:25:14 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:25:14 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:25:14 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 05:25:14 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:25:14 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:25:14 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 05:25:14 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:25:14 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 05:25:14 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:25:14 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 05:25:14 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:25:14 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 05:25:14 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 05:25:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:25:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:25:14 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:25:14 INFO - Expected file size: 16231139 05:25:21 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:25:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:25:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:25:21 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:25:22 INFO - Expected file size: 16231139 05:25:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 05:25:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 05:25:29 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 05:25:29 INFO - Expected file size: 14414089 05:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:30 INFO - trying https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 05:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 05:25:33 INFO - Downloaded 86009518 bytes. 05:25:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:25:33 INFO - mkdir: /builds/slave/test/properties 05:25:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:33 INFO - Contents: 05:25:33 INFO - build_url:https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:25:33 INFO - Running post-action listener: _resource_record_post_action 05:25:33 INFO - Running post-action listener: set_extra_try_arguments 05:25:33 INFO - [mozharness: 2016-11-18 13:25:33.727018Z] Finished download-and-extract step (success) 05:25:33 INFO - [mozharness: 2016-11-18 13:25:33.727148Z] Running populate-webroot step. 05:25:33 INFO - Running pre-action listener: _resource_record_pre_action 05:25:33 INFO - Running main action method: populate_webroot 05:25:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:33 INFO - '--tppagecycles', 05:25:33 INFO - '7'], 05:25:33 INFO - 'tests': ['tsvgm']}}, 05:25:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['damp', 'tps']}, 05:25:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'tests': ['damp', 'tps']}, 05:25:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['dromaeo_dom']}, 05:25:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['basic_compositor_video']}, 05:25:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:25:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['a11yr', 05:25:33 INFO - 'ts_paint', 05:25:33 INFO - 'tpaint', 05:25:33 INFO - 'sessionrestore', 05:25:33 INFO - 'sessionrestore_no_auto_restore', 05:25:33 INFO - 'tabpaint']}, 05:25:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:33 INFO - 'ts_paint', 05:25:33 INFO - 'tpaint', 05:25:33 INFO - 'sessionrestore', 05:25:33 INFO - 'sessionrestore_no_auto_restore', 05:25:33 INFO - 'tabpaint']}, 05:25:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:25:33 INFO - 'ts_paint', 05:25:33 INFO - 'tpaint', 05:25:33 INFO - 'sessionrestore', 05:25:33 INFO - 'sessionrestore_no_auto_restore', 05:25:33 INFO - 'tabpaint']}, 05:25:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:25:33 INFO - 'ts_paint', 05:25:33 INFO - 'tpaint', 05:25:33 INFO - 'sessionrestore', 05:25:33 INFO - 'sessionrestore_no_auto_restore', 05:25:33 INFO - 'tabpaint']}, 05:25:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['a11yr', 05:25:33 INFO - 'ts_paint', 05:25:33 INFO - 'tpaint', 05:25:33 INFO - 'sessionrestore', 05:25:33 INFO - 'sessionrestore_no_auto_restore', 05:25:33 INFO - 'tabpaint']}, 05:25:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['a11yr', 05:25:33 INFO - 'ts_paint', 05:25:33 INFO - 'tpaint', 05:25:33 INFO - 'sessionrestore', 05:25:33 INFO - 'sessionrestore_no_auto_restore', 05:25:33 INFO - 'tabpaint']}, 05:25:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['tsvgx', 05:25:33 INFO - 'tsvgr_opacity', 05:25:33 INFO - 'tart', 05:25:33 INFO - 'tscrollx', 05:25:33 INFO - 'cart']}, 05:25:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:33 INFO - 'tsvgr_opacity', 05:25:33 INFO - 'tart', 05:25:33 INFO - 'tscrollx', 05:25:33 INFO - 'cart']}, 05:25:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'talos_options': ['--disable-e10s'], 05:25:33 INFO - 'tests': ['tp5o']}, 05:25:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'tests': ['tp5o']}, 05:25:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'talos_options': ['--disable-e10s', 05:25:33 INFO - '--xperf_path', 05:25:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:33 INFO - 'tests': ['tp5n']}, 05:25:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:33 INFO - 'talos_options': ['--xperf_path', 05:25:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:33 INFO - 'tests': ['tp5n']}}, 05:25:33 INFO - 'talos.zip': {'path': '', 05:25:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:33 INFO - Running post-action listener: _resource_record_post_action 05:25:33 INFO - [mozharness: 2016-11-18 13:25:33.746222Z] Finished populate-webroot step (success) 05:25:33 INFO - [mozharness: 2016-11-18 13:25:33.746361Z] Running create-virtualenv step. 05:25:33 INFO - Running pre-action listener: _resource_record_pre_action 05:25:33 INFO - Running main action method: create_virtualenv 05:25:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:25:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:25:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:33 INFO - Using real prefix '/tools/python27' 05:25:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:37 INFO - Installing pip.................done. 05:25:37 INFO - Return code: 0 05:25:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:37 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:37 INFO - 'HOME': '/Users/cltbld', 05:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:37 INFO - 'LOGNAME': 'cltbld', 05:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:37 INFO - 'MOZ_NO_REMOTE': '1', 05:25:37 INFO - 'NO_EM_RESTART': '1', 05:25:37 INFO - 'PAGER': '/bin/cat', 05:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:37 INFO - 'PWD': '/builds/slave/test', 05:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:37 INFO - 'SHELL': '/bin/bash', 05:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:37 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:37 INFO - 'USER': 'cltbld', 05:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:37 INFO - 'XPC_FLAGS': '0x0', 05:25:37 INFO - 'XPC_SERVICE_NAME': '0', 05:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:25:37 INFO - Cleaning up... 05:25:37 INFO - Return code: 0 05:25:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:37 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:37 INFO - 'HOME': '/Users/cltbld', 05:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:37 INFO - 'LOGNAME': 'cltbld', 05:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:37 INFO - 'MOZ_NO_REMOTE': '1', 05:25:37 INFO - 'NO_EM_RESTART': '1', 05:25:37 INFO - 'PAGER': '/bin/cat', 05:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:37 INFO - 'PWD': '/builds/slave/test', 05:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:37 INFO - 'SHELL': '/bin/bash', 05:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:37 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:37 INFO - 'USER': 'cltbld', 05:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:37 INFO - 'XPC_FLAGS': '0x0', 05:25:37 INFO - 'XPC_SERVICE_NAME': '0', 05:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:38 INFO - Downloading/unpacking psutil>=3.1.1 05:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:41 INFO - Installing collected packages: psutil 05:25:41 INFO - Running setup.py install for psutil 05:25:41 INFO - building 'psutil._psutil_osx' extension 05:25:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:25:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:25:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:25:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:25:42 INFO - building 'psutil._psutil_posix' extension 05:25:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:25:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:25:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:25:42 INFO - ^ 05:25:42 INFO - 1 warning generated. 05:25:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:42 INFO - Successfully installed psutil 05:25:42 INFO - Cleaning up... 05:25:42 INFO - Return code: 0 05:25:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:42 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:42 INFO - 'HOME': '/Users/cltbld', 05:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:42 INFO - 'LOGNAME': 'cltbld', 05:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:42 INFO - 'MOZ_NO_REMOTE': '1', 05:25:42 INFO - 'NO_EM_RESTART': '1', 05:25:42 INFO - 'PAGER': '/bin/cat', 05:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:42 INFO - 'PWD': '/builds/slave/test', 05:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:42 INFO - 'SHELL': '/bin/bash', 05:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:42 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:42 INFO - 'USER': 'cltbld', 05:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:42 INFO - 'XPC_FLAGS': '0x0', 05:25:42 INFO - 'XPC_SERVICE_NAME': '0', 05:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:25:45 INFO - Installing collected packages: mozsystemmonitor 05:25:45 INFO - Running setup.py install for mozsystemmonitor 05:25:45 INFO - Successfully installed mozsystemmonitor 05:25:45 INFO - Cleaning up... 05:25:45 INFO - Return code: 0 05:25:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:45 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:45 INFO - 'HOME': '/Users/cltbld', 05:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:45 INFO - 'LOGNAME': 'cltbld', 05:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:45 INFO - 'MOZ_NO_REMOTE': '1', 05:25:45 INFO - 'NO_EM_RESTART': '1', 05:25:45 INFO - 'PAGER': '/bin/cat', 05:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:45 INFO - 'PWD': '/builds/slave/test', 05:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:45 INFO - 'SHELL': '/bin/bash', 05:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:45 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:45 INFO - 'USER': 'cltbld', 05:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:45 INFO - 'XPC_FLAGS': '0x0', 05:25:45 INFO - 'XPC_SERVICE_NAME': '0', 05:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:45 INFO - Downloading/unpacking jsonschema==2.5.1 05:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:48 INFO - warning: no files found matching '*.txt' 05:25:48 INFO - no previously-included directories found matching 'build' 05:25:48 INFO - no previously-included directories found matching 'dist' 05:25:48 INFO - no previously-included directories found matching '.git*' 05:25:48 INFO - Installing collected packages: jsonschema, functools32 05:25:48 INFO - Running setup.py install for functools32 05:25:49 INFO - warning: no files found matching '*.txt' 05:25:49 INFO - no previously-included directories found matching 'build' 05:25:49 INFO - no previously-included directories found matching 'dist' 05:25:49 INFO - no previously-included directories found matching '.git*' 05:25:49 INFO - Successfully installed jsonschema functools32 05:25:49 INFO - Cleaning up... 05:25:49 INFO - Return code: 0 05:25:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:49 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:49 INFO - 'HOME': '/Users/cltbld', 05:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:49 INFO - 'LOGNAME': 'cltbld', 05:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:49 INFO - 'MOZ_NO_REMOTE': '1', 05:25:49 INFO - 'NO_EM_RESTART': '1', 05:25:49 INFO - 'PAGER': '/bin/cat', 05:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:49 INFO - 'PWD': '/builds/slave/test', 05:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:49 INFO - 'SHELL': '/bin/bash', 05:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:49 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:49 INFO - 'USER': 'cltbld', 05:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:49 INFO - 'XPC_FLAGS': '0x0', 05:25:49 INFO - 'XPC_SERVICE_NAME': '0', 05:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:25:49 INFO - Cleaning up... 05:25:49 INFO - Return code: 0 05:25:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:49 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:49 INFO - 'HOME': '/Users/cltbld', 05:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:49 INFO - 'LOGNAME': 'cltbld', 05:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:49 INFO - 'MOZ_NO_REMOTE': '1', 05:25:49 INFO - 'NO_EM_RESTART': '1', 05:25:49 INFO - 'PAGER': '/bin/cat', 05:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:49 INFO - 'PWD': '/builds/slave/test', 05:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:49 INFO - 'SHELL': '/bin/bash', 05:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:49 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:49 INFO - 'USER': 'cltbld', 05:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:49 INFO - 'XPC_FLAGS': '0x0', 05:25:49 INFO - 'XPC_SERVICE_NAME': '0', 05:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:53 INFO - Downloading docopt-0.6.1.tar.gz 05:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:53 INFO - Running setup.py install for blobuploader 05:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:53 INFO - Running setup.py install for requests 05:25:54 INFO - Running setup.py install for docopt 05:25:54 INFO - Successfully installed blobuploader requests docopt 05:25:54 INFO - Cleaning up... 05:25:54 INFO - Return code: 0 05:25:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:54 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:54 INFO - 'HOME': '/Users/cltbld', 05:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:54 INFO - 'LOGNAME': 'cltbld', 05:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:54 INFO - 'MOZ_NO_REMOTE': '1', 05:25:54 INFO - 'NO_EM_RESTART': '1', 05:25:54 INFO - 'PAGER': '/bin/cat', 05:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:54 INFO - 'PWD': '/builds/slave/test', 05:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:54 INFO - 'SHELL': '/bin/bash', 05:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:54 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:54 INFO - 'USER': 'cltbld', 05:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:54 INFO - 'XPC_FLAGS': '0x0', 05:25:54 INFO - 'XPC_SERVICE_NAME': '0', 05:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:54 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ehS2iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:54 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-DuQ_ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:54 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-XTMVSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-j4HJUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-UUxO2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Wt4FZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-yYBZB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-N055Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Gotfm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IEYk7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hnFmmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-vkTMqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:55 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-I2U958-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-utdg1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-RoeT6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hr82Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-jMQFze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:56 INFO - Running setup.py install for manifestparser 05:25:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:25:56 INFO - Running setup.py install for mozcrash 05:25:56 INFO - Running setup.py install for mozdebug 05:25:56 INFO - Running setup.py install for mozdevice 05:25:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Running setup.py install for mozfile 05:25:57 INFO - Running setup.py install for mozhttpd 05:25:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Running setup.py install for mozinfo 05:25:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Running setup.py install for mozInstall 05:25:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Running setup.py install for mozleak 05:25:57 INFO - Running setup.py install for mozlog 05:25:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:25:57 INFO - Running setup.py install for moznetwork 05:25:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:25:58 INFO - Running setup.py install for mozprocess 05:25:58 INFO - Running setup.py install for mozprofile 05:25:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:25:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:25:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:25:58 INFO - Running setup.py install for mozrunner 05:25:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:25:58 INFO - Running setup.py install for mozscreenshot 05:25:58 INFO - Running setup.py install for moztest 05:25:58 INFO - Running setup.py install for mozversion 05:25:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:25:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:59 INFO - Cleaning up... 05:25:59 INFO - Return code: 0 05:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:59 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:59 INFO - 'HOME': '/Users/cltbld', 05:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:59 INFO - 'LOGNAME': 'cltbld', 05:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:59 INFO - 'MOZ_NO_REMOTE': '1', 05:25:59 INFO - 'NO_EM_RESTART': '1', 05:25:59 INFO - 'PAGER': '/bin/cat', 05:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:59 INFO - 'PWD': '/builds/slave/test', 05:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:59 INFO - 'SHELL': '/bin/bash', 05:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:25:59 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:59 INFO - 'USER': 'cltbld', 05:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:59 INFO - 'XPC_FLAGS': '0x0', 05:25:59 INFO - 'XPC_SERVICE_NAME': '0', 05:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JeFe58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FeFvNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-5nOfSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-NiSzfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hyhAnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-C3BigD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-tDY6J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-jmYIUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-EvhsPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-l0Gfa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-cxgJMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-_X16ID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pjcfT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-DGyZb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-YA_1XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:00 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-oA986t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IPvKtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:26:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:03 INFO - Downloading blessings-1.6.tar.gz 05:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:03 INFO - Installing collected packages: blessings 05:26:03 INFO - Running setup.py install for blessings 05:26:03 INFO - Successfully installed blessings 05:26:03 INFO - Cleaning up... 05:26:03 INFO - Return code: 0 05:26:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:04 INFO - Reading from file tmpfile_stdout 05:26:04 INFO - Current package versions: 05:26:04 INFO - blessings == 1.6 05:26:04 INFO - blobuploader == 1.2.4 05:26:04 INFO - docopt == 0.6.1 05:26:04 INFO - functools32 == 3.2.3-2 05:26:04 INFO - jsonschema == 2.5.1 05:26:04 INFO - manifestparser == 1.1 05:26:04 INFO - mozInstall == 1.12 05:26:04 INFO - mozcrash == 0.17 05:26:04 INFO - mozdebug == 0.1 05:26:04 INFO - mozdevice == 0.48 05:26:04 INFO - mozfile == 1.2 05:26:04 INFO - mozhttpd == 0.7 05:26:04 INFO - mozinfo == 0.9 05:26:04 INFO - mozleak == 0.1 05:26:04 INFO - mozlog == 3.4 05:26:04 INFO - moznetwork == 0.27 05:26:04 INFO - mozprocess == 0.23 05:26:04 INFO - mozprofile == 0.28 05:26:04 INFO - mozrunner == 6.12 05:26:04 INFO - mozscreenshot == 0.1 05:26:04 INFO - mozsystemmonitor == 0.3 05:26:04 INFO - moztest == 0.7 05:26:04 INFO - mozversion == 1.4 05:26:04 INFO - psutil == 3.1.1 05:26:04 INFO - requests == 1.2.3 05:26:04 INFO - wsgiref == 0.1.2 05:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:04 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:04 INFO - 'HOME': '/Users/cltbld', 05:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:04 INFO - 'LOGNAME': 'cltbld', 05:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:04 INFO - 'MOZ_NO_REMOTE': '1', 05:26:04 INFO - 'NO_EM_RESTART': '1', 05:26:04 INFO - 'PAGER': '/bin/cat', 05:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:04 INFO - 'PWD': '/builds/slave/test', 05:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:04 INFO - 'SHELL': '/bin/bash', 05:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:26:04 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:04 INFO - 'USER': 'cltbld', 05:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:04 INFO - 'XPC_FLAGS': '0x0', 05:26:04 INFO - 'XPC_SERVICE_NAME': '0', 05:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:26:04 INFO - Cleaning up... 05:26:04 INFO - Return code: 0 05:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:04 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 0x104ee3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1725ca950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, '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.d09wc38ilG/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.m4a9TPSXUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:04 INFO - 'HOME': '/Users/cltbld', 05:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:04 INFO - 'LOGNAME': 'cltbld', 05:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:04 INFO - 'MOZ_NO_REMOTE': '1', 05:26:04 INFO - 'NO_EM_RESTART': '1', 05:26:04 INFO - 'PAGER': '/bin/cat', 05:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:04 INFO - 'PWD': '/builds/slave/test', 05:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:04 INFO - 'SHELL': '/bin/bash', 05:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:26:04 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:04 INFO - 'USER': 'cltbld', 05:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:04 INFO - 'XPC_FLAGS': '0x0', 05:26:04 INFO - 'XPC_SERVICE_NAME': '0', 05:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:05 INFO - Cleaning up... 05:26:05 INFO - Return code: 0 05:26:05 INFO - Running post-action listener: _resource_record_post_action 05:26:05 INFO - Running post-action listener: _start_resource_monitoring 05:26:05 INFO - Starting resource monitoring. 05:26:05 INFO - [mozharness: 2016-11-18 13:26:05.169403Z] Finished create-virtualenv step (success) 05:26:05 INFO - [mozharness: 2016-11-18 13:26:05.170358Z] Running install step. 05:26:05 INFO - Running pre-action listener: _resource_record_pre_action 05:26:05 INFO - Running main action method: install 05:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:05 INFO - Reading from file tmpfile_stdout 05:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:05 INFO - Reading from file tmpfile_stdout 05:26:05 INFO - Output received: 05:26:05 INFO - Usage: mozinstall [options] installer 05:26:05 INFO - Options: 05:26:05 INFO - -h, --help show this help message and exit 05:26:05 INFO - -d DEST, --destination=DEST 05:26:05 INFO - Directory to install application into. [default: 05:26:05 INFO - "/builds/slave/test"] 05:26:05 INFO - --app=APP Application being installed. [default: firefox] 05:26:05 INFO - mkdir: /builds/slave/test/build/application 05:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:26:27 INFO - Reading from file tmpfile_stdout 05:26:27 INFO - Output received: 05:26:27 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:26:27 INFO - Running post-action listener: _resource_record_post_action 05:26:27 INFO - [mozharness: 2016-11-18 13:26:27.625726Z] Finished install step (success) 05:26:27 INFO - [mozharness: 2016-11-18 13:26:27.625857Z] Running run-tests step. 05:26:27 INFO - Running pre-action listener: _resource_record_pre_action 05:26:27 INFO - Running main action method: run_tests 05:26:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:27 INFO - 2016-11-18 05:26:27.640 screenresolution[1623:7414] starting screenresolution argv=screenresolution get 05:26:27 INFO - 2016-11-18 05:26:27.642 screenresolution[1623:7414] Display 0: 1600x1200x32@60 05:26:27 INFO - 2016-11-18 05:26:27.648 screenresolution[1624:7416] starting screenresolution argv=screenresolution list 05:26:27 INFO - Available Modes on Display 0 05:26:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:27 INFO - Intel Iris: 05:26:27 INFO - Chipset Model: Intel Iris 05:26:27 INFO - Type: GPU 05:26:27 INFO - Bus: Built-In 05:26:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:27 INFO - Vendor: Intel (0x8086) 05:26:27 INFO - Device ID: 0x0a2e 05:26:27 INFO - Revision ID: 0x0009 05:26:27 INFO - Displays: 05:26:27 INFO - Display: 05:26:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:27 INFO - Display Serial Number: 1600x1200 60 05:26:27 INFO - Main Display: Yes 05:26:27 INFO - Mirror: Off 05:26:27 INFO - Online: Yes 05:26:27 INFO - Rotation: Supported 05:26:27 INFO - Return code: 0 05:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:27 INFO - Python 2.7.3 05:26:27 INFO - Return code: 0 05:26:27 INFO - grabbing minidump binary from tooltool 05:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:27 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 0x104cf7d30>, '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 0x104b5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cefb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:26:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:26:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:26:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:28 INFO - Return code: 0 05:26:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:26:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:26:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d09wc38ilG/Render', 05:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:28 INFO - 'HOME': '/Users/cltbld', 05:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:28 INFO - 'LOGNAME': 'cltbld', 05:26:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:28 INFO - 'MOZ_NO_REMOTE': '1', 05:26:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:28 INFO - 'NO_EM_RESTART': '1', 05:26:28 INFO - 'PAGER': '/bin/cat', 05:26:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:28 INFO - 'PWD': '/builds/slave/test', 05:26:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:28 INFO - 'SHELL': '/bin/bash', 05:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4a9TPSXUH/Listeners', 05:26:28 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:28 INFO - 'USER': 'cltbld', 05:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:28 INFO - 'XPC_FLAGS': '0x0', 05:26:28 INFO - 'XPC_SERVICE_NAME': '0', 05:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:26:28 INFO - mozversion application_buildid: 20161118040828 05:26:28 INFO - mozversion application_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 05:26:28 INFO - mozversion application_display_name: Firefox 05:26:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:28 INFO - mozversion application_name: Firefox 05:26:28 INFO - mozversion application_remotingname: firefox 05:26:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:26:28 INFO - mozversion application_vendor: Mozilla 05:26:28 INFO - mozversion application_version: 51.0 05:26:28 INFO - mozversion platform_buildid: 20161118040828 05:26:28 INFO - mozversion platform_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 05:26:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:26:28 INFO - mozversion platform_version: 51.0 05:26:28 INFO - using testdate: 1479475588 05:26:28 INFO - actual date: 1479475588 05:26:28 INFO - starting webserver on 'localhost:49241' 05:26:28 INFO - SUITE-START | Running 2 tests 05:26:28 INFO - TEST-START | dromaeo_css 05:26:28 INFO - operating with platform_type : mac_ 05:26:28 INFO - Initialising browser for dromaeo_css test... 05:26:28 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpPc_CL_/profile http://localhost:49241/getInfo.html) 05:26:30 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 05:26:30 INFO - PROCESS | 1634 | colorDepth:24 05:26:30 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 05:26:30 INFO - PROCESS | 1634 | __metrics 05:26:30 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 05:26:31 INFO - TEST-INFO | 1634: exit 0 05:26:31 INFO - Browser initialized. 05:26:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:31 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpPc_CL_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:43 INFO - PROCESS | 1638 | RSS: Main: 174186496 05:26:43 INFO - PROCESS | 1638 | 05:27:33 INFO - PROCESS | 1638 | 1479475653051 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:29:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:29:46 INFO - PROCESS | 1638 | RSS: Main: 186699776 05:29:46 INFO - PROCESS | 1638 | 05:32:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:32:49 INFO - PROCESS | 1638 | RSS: Main: 196841472 05:32:49 INFO - PROCESS | 1638 | 05:35:51 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:35:52 INFO - PROCESS | 1638 | RSS: Main: 198664192 05:35:52 INFO - PROCESS | 1638 | 05:38:54 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:38:55 INFO - PROCESS | 1638 | RSS: Main: 203116544 05:38:55 INFO - PROCESS | 1638 | 05:41:57 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:41:58 INFO - PROCESS | 1638 | RSS: Main: 205807616 05:41:58 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:45:00 INFO - PROCESS | 1638 | RSS: Main: 207626240 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | __start_tp_report 05:45:00 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 05:45:00 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 05:45:00 INFO - PROCESS | 1638 | |i|pagename|runs| 05:45:00 INFO - PROCESS | 1638 | |0;dojo.html;3615.4576813477975;3628.9274214515726;3638.981805090974;3644.2529281497295;3691.6492933171357;6016.849578760533;6044.24446944132;6080.665563394012;6085.056816193492;6117.877642447154;5549.6115271930985;5776.942230577693;6015.669138197398;6051.394860513958;6129.601575897575;5360.115580929142;5387.380451248097;5401.972990135044;5467.398586155519;5524.475174858382;5461.508464238218;5498.615096943216;5506.724663766816;5509.669419834822;5571;5330.466953304658;5379.838604841861;5471.644343117685;5486.478784515464;5487.2317875497265;5436.130219164915;5441.2654291670715;5459.863503412446;5463.262459567987;5476.123820188751;5257.080010998098;5389.622726409153;5400.923132255667;5424.349078110613;5437.891242175135;5956.16613674086;6037.818865434044;6053.243344581927;6089.482393996515;6111.419415155553;6133.110698948627;6207.224096987877;6232.968835155841;6374.139491168679;6384.553081284312;6482.546221764478;6497.772577959749;6508.8047358579315;6512.348765123497;6514.3811337922825;5758.568107391962;5770.278715160605;6027.578069535134;6078.75684972605;6098.1157732128595;6480.805575832733;6485.092087107809;6528.51036172289;6615.338466153346;6640.667966601747;5438.45615438453;5568.747031917786;6222.844428889223;6318.936810631927;6347.587406818542;5128.384593848762;5272.7100009499845;6317.1156038154695;6341.397567231105;6467.870642587122;5230.476952304739;6247.437730604177;6335.334789847092;6342.365763423713;6347.809565713036;6206.596571222856;6342.5560210785725;6360.1731774869895;6375.362463753588;6389.9361006389345;5145.15105007677;5162.638615296968;5177.197534382177;5184.326037615086;5246.501582349671;4646.8141274348645;4662.906741865144;4672.976635116871;4680.08738296029;4681.64887633422;6040.879182416327;6100.749346383981;6163;6227.906581401283;6239.688015599202;6277.5605707600025;6301.275353334334;6445.129907462527;6466.64433456155;6523.575967562093;6153.784617538365;6186.1648677428875;6198.938010619926;6210.968945155245;6237.5321850860455;5705.4579814917515;5719.342275638355;5728.914066289009;5730.169125476783;5732.541396688255;6532.08550802888;6599.769008084694;6606.372394622503;6625.304343043911;6640.435562977008;6481.189851268591;6492.64290464029;6495.642739649175;6501.08984742127;6528.37980391862;6676.465882729467;6679.833004174934;6764.763233286812;6770.695318710768;6789.694463749044;6239.812805615838;6294.307626161027;6314.62112273265;6350.460210882126;6420.101185834081;6464.5798023128345;6484.448821850196;6493.935060649522;6501.44737697301;6502.837429064311;6257.530685198537;6296.307406185224;6306.211723534559;6336.081268216175;6372.458341041063;6177.938220617736;6200.162977997912;6202.658853763086;6276.246850377801;6326.715297811517;4974;6164.599301045418;6300.117983482224;6305.684715764285;6307.905381419374;6274.058891166362;6307.558470907176;6307.810765677037;6318.115463835159;6326.841828954313;6151.98492248774;6185.288691800501;6262.279837818527;6282.937170628235;6295.653739044396 05:45:00 INFO - PROCESS | 1638 | |1;ext.html;478.45456179954834;512.2828040742961;530.8885134121834;545.6862304175099;546.3607579132415;41112.79443602781;42675.35986960198;42723.57276427235;42745.14509709804;42814;43738.12523749523;44002.55997440025;44062.33906491405;44241.77879110608;44374.55625443745;10048.397096174216;10300.330478518872;10345.379277243352;10385.324953877975;10446.11208047313;7921.524708517479;9996.850047249298;10024.599016039387;10052.497375131214;10059.24555658325;10012.449315287657;10053.447060411674;10056.245781566375;10097.596096156145;10107.837598676137;8473.195046470575;9972.152367048773;10015.699529014104;10029;10034.197264218845;8980.685676001374;9824.263180261438;10050.547725352304;10152;10163.796724065478;42169;42439.1512169758;42553.57446425527;42829.92925176864;42855;3496.213351995806;3986.421968814506;4261.403403523509;4265.253580623409;4276.700630955803;31368.529472057937;31513.054608361555;32950.01149965505;33342.83328583366;33466.49800252998;3384.76306658534;3407.267437500924;3417.9316413671836;3420.6579342065843;3483.651634836521;535569;545575;546097;546551;546836;34509;34810.825945870616;61036.69481652652;61458;61514.69242653847;36114.09714757152;36302.81848590793;36528.26943461116;36683.26633467369;36726.81636591853;15898.682026359407;16067.196640167946;16069.598260043593;16070.276837542338;16151.919240403722;13552.93223533876;13583.320833958263;13598.184108953297;13621.591352259447;13665.795013074812;7917.129115797257;7925.445218834626;7955.801104972306;7978.760637180894;8027.478213916077;2959.5708622249654;3378.273671160712;3421.110511267039;3423.1613254752747;3495.291149359267;990.3708399682482;1001.884783249921;1061.098066643347;1108.3017698849835;1108.3848464102339;30867.382652346827;31065.534016989764;31244.06267811969;31321.90373336922;31828.840855795574;1063.2509521836535;1086.9565217391216;1100.2078503477483;1134.3080720760329;1200.6698158006618;13769.869039288173;14781.852181478047;15729.921350393175;15873.444429444913;16254.67490650204;768648;774289;774414;776091;779041;56019.71990140023;57619.42380576224;57787.71106144526;57903.13145302824;57983.710081449324;1393.9372728227254;1422.4879043544315;1429.0996672096512;1437.9568612941628;1440.6110350205386;29935.55096673508;30569.388612228075;30647;30789.92235271755;30952.53571196479;50447.49552504428;50665.74667126641;50936.23595645994;50986.725331867;51074.723131922;627500;635935;645638;649637;651827;26768.33079173036;26879.731202687723;26900.327491812863;26936;27250.04624838121;49231.753841230566;49277.260841086696;49993.75015624639;50132;50602.493975061254;40511.797441012604;40959.79520102381;41261.58738412698;41280.761577152734;41944;40558.98602534842;41026.79486602548;41743.7912810434;41991.79004105082;42021.73934781962;33957.49063764095;34292;38353.80823095867;39602.60397396104;40397.798011009756;33677.49483757697;35545.345585298266;35826.283474329844;36153.27693446169;36164.4575331365;21753.673694894274;26791.866040669673;27012.864935675196;27019.59470607903;27186.592201116604 05:45:00 INFO - PROCESS | 1638 | |2;jquery.html;373.93269211541946;383.3444809375967;385.3756913799645;389.846010825724;409.3859211183225;16763.580910477245;17155.39956101535;18555.721664175013;19726.112324945378;20960.685589716166;17090.914545427288;21083.94580270984;21084.15663373467;21437.035333409996;21460.141594336208;5768.394318596529;5971.671558064305;5991.101334799771;6190.907136392958;6243.87512249757;6058.545609079315;6130.2643682758135;6167.167432396636;6174.722137503801;6175.351588083254;5893.263342082239;6155.8768824623485;6212.720427580747;6246.656433896134;6286.811395658137;6231.40801623845;6233.096201050845;6266.404691554295;6338.3027866934835;6747.257801641816;5231.110711179109;5931.881362372772;6021.42796434338;6040.697965101727;6102.908456373158;13100;16379.344826206938;19670;24619.38451538708;25009.499810003697;2224.5439684864564;2256.8420210585264;2262.886855657227;2441.121196369306;2441.816863735227;9865.753356166082;9986.750331241705;10162.03460671235;10409.271351005433;10428.478576071242;1929.6719557675228;1979.1885327015998;2004.0781240629328;2040.6020825938947;2073.979260207409;120976;123800;129832;139085;140404.29797851047;9986.551949967214;10957.83563246536;11463.484143213574;11535.90408911152;11932;12697.666744991828;14030.579082627537;14260.35828387725;14638.121712697272;14688.779668304984;8618.310535157172;8754.606042728092;8782.209601135928;8782.209601135928;8869.246114080375;8903;9077.818443631091;9105.317101217435;9163.633454661738;9239;4492.752898590544;4575.084983003413;4600.171969045604;4608.400907882021;4635.930461043087;1932.21745193197;1932.9710054349196;1951.7853036166011;1958.4712127725434;1960.8529360298035;884.2616415293173;929.2844509727472;937.7889974755761;955.1594596754811;989.8218320702342;20506.89746551258;20580;21890.233841815778;21932;22063.66904496434;870.6125774030496;952.8237276103943;1007.1137399088755;1008.7377281906611;1039.2205845615788;10994.505247263893;11273.887261127447;11325.830112548318;11405.201635885409;11537.538498460135;664843;681090;691146;709115;713675;112927;123079.99999999821;149200;154078.22960885125;155207;893.5666201892207;1019.9592016319413;1044.3159730376615;1055.7941201465794;1057.3074636113358;18243.726344104583;18923.526911826764;19249.807501924803;19252.326168584033;19290.324838630582;59131.70434147802;59456.40543594509;59719.70140149271;60059;60913.69543152256;87959;88317;90502.54748726478;92262;92607.61088583812;6631.469482441296;6678.632675202911;8228.177182281725;8233.423660343718;8391.244787969112;9168.266538677024;12554.372281386077;13222.735545288848;13490.043943628316;13731.244781536712;9921.801563968536;10359.63741269052;10501.579936802442;11734.589289375172;11996.700082498008;9038.276937845088;10828.296160749525;11545.191836571359;11603.419829008684;11673.883261167619;10732.51703673321;11602.94198529002;11801.81981801813;12029;12034.75930481403;6686.598804071771;8129.552874591717;8239.670413183645;8487.660493580188;8522.27560657351;9575.808483830424;11609.071274297867;11614.941925290319;11718.003969662674;11905 05:45:00 INFO - PROCESS | 1638 | |3;mootools.html;1309.6922223277531;1438.9424423023079;1537.8158817710364;1592.1959410497698;1698.2442812948243;8507.617157227924;8738.563071846398;9017.323700722447;9480.715578532647;9494.57581362796;8935;9152.679656212034;9198.632054717804;9245.399049061807;9272.397294175891;2484.2050543826026;2505.110685706566;2509.034021901572;2512.57286261336;2518.672572565573;2453.129139155601;2495.25142457263;2501.2746303572035;2506.7117281512587;2513.1078467144175;2442.645816356627;2493.8004959603277;2497.2383423055962;2501.9374515637073;2506.7117281512587;2436.3421876093357;2447.865367404792;2455.435249892517;2471;2482.342179322481;1844.483544607512;1949.8245157935853;2304.896279667419;2435.415500279938;2436.6588677584973;6958.373746362801;9059.320550958639;9153.588088536031;9183;9264;5471.480209380103;5635.09838425854;5643.661380317194;5650.0959846424785;5650.830475085754;3336.9499457507914;3461.29043546075;3721.9441708374397;3748.5501739791125;3803.5055442792536;1003.8544411060428;1007.8840933292691;1060.4114716332433;1081.9080378167787;1082.8592283003238;11550.711232219177;11621.825672614917;11663.766724665544;11686.76626467466;11757.941210293893;4824.107540105022;4883.536064073907;4921.458639549646;5003.5997120230295;5024.547790698854;10258.743531411774;10259.897401025893;10273.02406271403;10280;10310.484475776331;5499.697516636624;5548.805791797267;5569.526590239794;5582.967151077064;5590.161475778666;4673.859784206479;4679.99380133273;4786.2581299898575;5093.668911520814;5101.387833459934;3436.9828150859585;4082.040720430696;4207.26372884744;4241.427407299975;4281.143771245764;1298.2405292903568;1298.9415476303589;1307.2809954524973;1320.8414990201238;1322.418136020148;705.3757424679093;809.5749731390949;865.7619154732499;950.6245033211843;954.5131982688879;5778.855528611734;5861.9413805861395;5874.471297583153;5897.233359663216;6064.545159113084;981.4062492192263;984.670135504614;996.5714742660725;1011.4083261292079;1018.4093225928943;3494.021673931303;3626.9093272667865;3855.768653880776;3981.3629819228786;4001.559828418872;10823.404712740874;11073.50169242386;11171;11190.94404527972;11213.719657008476;11052.502637381176;11100.722481937855;11126;11128.888711112948;11197.776044479227;7762.611869406507;8405.201505856934;8427.452215605967;8574.228319451155;8667.219950204511;5592.888142237214;5776.913346299725;6006.339302676614;6012.3386427493815;6049.334573197033;10156.847647285149;10245.360742281198;10283.382997020202;10402.947985260025;10458.68623941283;10121.645742398981;10323.277370583986;10642.255042146975;10771.676849694522;10802.189835762192;6938.548994315353;7061.858762824612;7304.96347518259;7360.558366498028;7496.700131994659;8646;8670.78323041929;8807.735767926972;8810.691625793066;8816.294696424398;7744.922550774646;7795.571243581658;7855.60721963888;7856.882146767917;7991.200879911962;7758.534487930742;7763.650635721293;7793.844123117619;7800.804979875548;7845.803854903673;7138.214796372291;7149.285071492809;7234.855302894018;7244.094488188976;7284.053073100675;4993.850184494471;5009.298698182184;5059.291699162047;5122.718250496258;5243.265942767939;5051.3433253676785;5084.872429787794;5108.106081435808;5275.762590683506;5281.894362112813 05:45:00 INFO - PROCESS | 1638 | |4;prototype.html;305.5569424334715;307.63698835374265;311.285599549035;312.36433857100803;312.9499280115182;4936.728479933602;4981.476944920785;5678.602497825149;5685.715714214288;5784.363719990798;4381.414965170548;4510.9850283686155;4778.972520908004;5108.693478391299;5159.509846564571;3585.6055833858254;4009.6591789697836;4138.02756352257;4167.124903770196;4203.495580530325;4173.728707634009;4182.247195504808;4222.936655950163;4244.320908654616;4260.70175087744;4245.172191422674;4252.554131595257;4285.764282964436;4303.612674859262;4368.388425620416;3669.559652841676;4084.6323830855217;4197.412362269285;4243.133021470543;4300.204462174492;3480.3039392121677;3546.769459985093;3617.9095522612147;3646.9270614587826;3687.078230442389;5175.473235395567;5451.291332126838;5462.289902312674;5475.479829416239;5528.44715528448;3832.3485007548784;4556.476005259405;4883.218685010382;4898.363212782351;4994.825181118644;4687.109449204674;5999.400059993965;6001.759929602855;6077.969610151965;6087.54343424245;3116.439040972624;4083;4095.9385609215888;4121.175764847043;4133.256013917494;5104.596236035083;6130.877382452326;6146.354632763585;6257.177379894327;6345.809625711236;3442.759006869495;4093.9500072446217;4135.731177473454;4194.224068547267;4223.155368926227;3884.980575097163;3906.121122747416;4234.581415225873;4246.72396294246;4279.957200428018;4574.656900732459;4773.809047638125;4973.651844370932;5011.724355160428;5042.571381432619;4551.043051487892;4906.411230652345;5798.6810725410505;5938.792142275;6040.275166979991;1427.9000469967211;1453.5130731204954;1454.8836093112525;1458.8687018168416;1462.5466105507326;764.4304992780415;822.8642274024719;887.5296093070683;904.5974541329177;912.7900582865846;4370.5088099782815;5410.242566040757;5772.538196944234;5774.942250577525;5864.912026319608;5276.709780962007;6301.590396624297;6355.5551111421755;6381.425671689571;6424.550281480345;4823.517648235148;4990.8770526631215;5145.974270128625;5331.893362132736;5813;3196.7602429817393;3199.40810949975;3271.871204434466;3274.2141885947203;3280.6063272407464;5714.771324165241;6042.3655516170165;6197.628142311386;6632.43624291931;6633.137692100093;5469.425710300361;5525.226468294442;6342.5560210785725;6502.122213501211;6506.707198176094;5722.197507785035;5880.735366908414;5955.851103722355;6169.722362493609;6546.672666366662;5870.911936321044;5975.701214939322;6131;6281.277653069956;6324.588901721373;4826.95173048265;5366.463353664602;6198.675496688742;6224.439800417984;6234.537357743757;5789.044807606698;6105.481034111973;6408.58344207625;6471.4822814175695;6500.869982600416;4129.958700412957;4142.523609784913;4164.833406663821;4180.728252663567;4186.079062606222;5411.834077064961;5461.317335333083;5656.349519805275;6265;6350.618962862059;5073.068372011573;5721.628094173865;5810.970945145247;5988.461038506555;6082.635041897501;5501.9174712380145;5786.710664466844;5831.504322132666;6123.908141377794;6125.264968203844;4379.605835474823;5673.177389278614;5824.737886795019;5938.495227905676;5953.404659534185;5468.414159893746;6137.754489820357;6181.289151747606;6196.752129914753;6198.473129784019;5263.73681315925;5942.881142377215;6063.877642824976;6067.938110830499;6099.688566958125 05:45:00 INFO - PROCESS | 1638 | |5;yui.html;587.251254650321;716.4053835316688;782.3897360059156;784.6508303804806;838.8238469921314;16027.59931001724;16413.671726565462;16653.500394988154;17012.659746805057;17038.574035649115;15244.695106097872;15317.540473785777;15328.693426131471;15398.230088495558;15400.61498462539;687.9002544631026;690.2579726793692;713.3722324354561;859.166608389864;884.9601767920427;847.5550336073549;852.1393392673414;852.1478521478522;852.8720691896203;854.239726643288;885.8848349714528;910.6630546697731;911.389369122686;912.192709452133;912.5665308978215;904.159132007233;904.7059705595708;905.1853332001251;905.6332185464864;905.8324210021134;657.7237560224717;671.3890359772583;676.1615596660106;676.2730065179951;678.3081257117713;15277.00699454543;15388.30752616135;15427.691446171126;15430.5370838875;15441.845581544154;15186.924065379602;15291.770623440658;15309.846901530953;15329.386824527006;15340.846591534053;11939.462724177432;11988.160828741991;12163.20939138962;12285.754284914341;12382.876171238262;3164.604424446944;3674.65090816372;3926;3977.1449138435373;3991.1419044905197;124810;128629;129720;130247;132980;11280.041196498225;11288.435578221057;11539;11923.701907452383;11938.52245910154;23369.532609348058;23577.882110589337;24394.268171954514;24425.511489770106;24450.51098978046;8224.013118425828;8386.916130838736;8630.870536941951;8757.737267881846;8790.989036260784;4570.7257564546235;4625.976870115628;4639.0721855628335;4702.31816386622;4705.7411842349;3345.4480010797947;3483.216276337854;3487.982560087183;3488.633693462201;3496.1609213788506;545.7735039958452;627.9874402511924;628.2241431831684;635.8219698484339;636.0840389838618;467.04955415729506;542.4981891750116;553.4880235781966;569.6297406685687;668.6823758714669;7554.131274903347;8545.74362769118;9659.613615455444;9816.65641702537;9834.508274586242;600.4895838537295;618.1994317359031;622.8007037747877;631.6084027902638;658.6640813185214;4080.3063479208604;4552.9772351138035;4610.147122782296;4708.8116475341285;4732.100900828831;129533;133074;134578;142888.2855585736;175791.36312955315;107720.38419423715;114692.85307146989;120986;132583;134580;80324.19675803283;87915;115892;119178;125122.99999999818;9453.43279403238;10622.84065738999;10724.839127413252;10784.514696838503;10787.190960678137;56413;65979.67010164919;66249.66875165787;66479.00281495879;67584.6620766893;56677.71661141833;68570.65714671394;69715.18577224927;71276.50532231347;100449.49775251077;13767;13849.16904985704;13992.580222593338;14329.068610540282;14356;15410.152441615819;15418.152001640017;15425.382984680487;15703.214839257764;16175;14468.421263149356;14891;15171;15271.770923435935;15596.610084747972;14452.277386130441;14497.85502144965;14520.491782787552;14607.415703372171;14954.925225374238;13488.662783430493;14070;14142.292885355486;14142.78785818234;14527.564173074825;11010.724731881766;11209.887901120885;11313.71715707114;11435.656930292105;11902.761944761229;11755.235909665844;11852.822207666719;12157.723439039128;12208.32854193028;12214.755704885674 05:45:00 INFO - PROCESS | 1638 | __end_tp_report 05:45:00 INFO - PROCESS | 1638 | __start_cc_report 05:45:00 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,360 05:45:00 INFO - PROCESS | 1638 | __end_cc_report 05:45:00 INFO - PROCESS | 1638 | __startTimestamp1479476700922__endTimestamp 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | ------- Summary: start ------- 05:45:00 INFO - PROCESS | 1638 | Number of tests: 6 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5955.87 Median:6200.16 stddev:640.76 (10.3%) stddev-sans-first:615.86 05:45:00 INFO - PROCESS | 1638 | Values: 3615.5 3628.9 3639.0 3644.3 3691.6 6016.8 6044.2 6080.7 6085.1 6117.9 5549.6 5776.9 6015.7 6051.4 6129.6 5360.1 5387.4 5402.0 5467.4 5524.5 5461.5 5498.6 5506.7 5509.7 5571.0 5330.5 5379.8 5471.6 5486.5 5487.2 5436.1 5441.3 5459.9 5463.3 5476.1 5257.1 5389.6 5400.9 5424.3 5437.9 5956.2 6037.8 6053.2 6089.5 6111.4 6133.1 6207.2 6233.0 6374.1 6384.6 6482.5 6497.8 6508.8 6512.3 6514.4 5758.6 5770.3 6027.6 6078.8 6098.1 6480.8 6485.1 6528.5 6615.3 6640.7 5438.5 5568.7 6222.8 6318.9 6347.6 5128.4 5272.7 6317.1 6341.4 6467.9 5230.5 6247.4 6335.3 6342.4 6347.8 6206.6 6342.6 6360.2 6375.4 6389.9 5145.2 5162.6 5177.2 5184.3 5246.5 4646.8 4662.9 4673.0 4680.1 4681.6 6040.9 6100.7 6163.0 6227.9 6239.7 6277.6 6301.3 6445.1 6466.6 6523.6 6153.8 6186.2 6198.9 6211.0 6237.5 5705.5 5719.3 5728.9 5730.2 5732.5 6532.1 6599.8 6606.4 6625.3 6640.4 6481.2 6492.6 6495.6 6501.1 6528.4 6676.5 6679.8 6764.8 6770.7 6789.7 6239.8 6294.3 6314.6 6350.5 6420.1 6464.6 6484.4 6493.9 6501.4 6502.8 6257.5 6296.3 6306.2 6336.1 6372.5 6177.9 6200.2 6202.7 6276.2 6326.7 4974.0 6164.6 6300.1 6305.7 6307.9 6274.1 6307.6 6307.8 6318.1 6326.8 6152.0 6185.3 6262.3 6282.9 6295.7 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:76531.85 Median:35970.19 stddev:177442.92 (493.3%) stddev-sans-first:177848.81 05:45:00 INFO - PROCESS | 1638 | Values: 478.5 512.3 530.9 545.7 546.4 41112.8 42675.4 42723.6 42745.1 42814.0 43738.1 44002.6 44062.3 44241.8 44374.6 10048.4 10300.3 10345.4 10385.3 10446.1 7921.5 9996.9 10024.6 10052.5 10059.2 10012.4 10053.4 10056.2 10097.6 10107.8 8473.2 9972.2 10015.7 10029.0 10034.2 8980.7 9824.3 10050.5 10152.0 10163.8 42169.0 42439.2 42553.6 42829.9 42855.0 3496.2 3986.4 4261.4 4265.3 4276.7 31368.5 31513.1 32950.0 33342.8 33466.5 3384.8 3407.3 3417.9 3420.7 3483.7 535569.0 545575.0 546097.0 546551.0 546836.0 34509.0 34810.8 61036.7 61458.0 61514.7 36114.1 36302.8 36528.3 36683.3 36726.8 15898.7 16067.2 16069.6 16070.3 16151.9 13552.9 13583.3 13598.2 13621.6 13665.8 7917.1 7925.4 7955.8 7978.8 8027.5 2959.6 3378.3 3421.1 3423.2 3495.3 990.4 1001.9 1061.1 1108.3 1108.4 30867.4 31065.5 31244.1 31321.9 31828.8 1063.3 1087.0 1100.2 1134.3 1200.7 13769.9 14781.9 15729.9 15873.4 16254.7 768648.0 774289.0 774414.0 776091.0 779041.0 56019.7 57619.4 57787.7 57903.1 57983.7 1393.9 1422.5 1429.1 1438.0 1440.6 29935.6 30569.4 30647.0 30789.9 30952.5 50447.5 50665.7 50936.2 50986.7 51074.7 627500.0 635935.0 645638.0 649637.0 651827.0 26768.3 26879.7 26900.3 26936.0 27250.0 49231.8 49277.3 49993.8 50132.0 50602.5 40511.8 40959.8 41261.6 41280.8 41944.0 40559.0 41026.8 41743.8 41991.8 42021.7 33957.5 34292.0 38353.8 39602.6 40397.8 33677.5 35545.3 35826.3 36153.3 36164.5 21753.7 26791.9 27012.9 27019.6 27186.6 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:38701.21 Median:2352.00 stddev:115487.28 (4910.2%) stddev-sans-first:115775.39 05:45:00 INFO - PROCESS | 1638 | Values: 373.9 383.3 385.4 389.8 409.4 16763.6 17155.4 18555.7 19726.1 20960.7 17090.9 21083.9 21084.2 21437.0 21460.1 5768.4 5971.7 5991.1 6190.9 6243.9 6058.5 6130.3 6167.2 6174.7 6175.4 5893.3 6155.9 6212.7 6246.7 6286.8 6231.4 6233.1 6266.4 6338.3 6747.3 5231.1 5931.9 6021.4 6040.7 6102.9 13100.0 16379.3 19670.0 24619.4 25009.5 2224.5 2256.8 2262.9 2441.1 2441.8 9865.8 9986.8 10162.0 10409.3 10428.5 1929.7 1979.2 2004.1 2040.6 2074.0 120976.0 123800.0 129832.0 139085.0 140404.3 9986.6 10957.8 11463.5 11535.9 11932.0 12697.7 14030.6 14260.4 14638.1 14688.8 8618.3 8754.6 8782.2 8782.2 8869.2 8903.0 9077.8 9105.3 9163.6 9239.0 4492.8 4575.1 4600.2 4608.4 4635.9 1932.2 1933.0 1951.8 1958.5 1960.9 884.3 929.3 937.8 955.2 989.8 20506.9 20580.0 21890.2 21932.0 22063.7 870.6 952.8 1007.1 1008.7 1039.2 10994.5 11273.9 11325.8 11405.2 11537.5 664843.0 681090.0 691146.0 709115.0 713675.0 112927.0 123080.0 149200.0 154078.2 155207.0 893.6 1020.0 1044.3 1055.8 1057.3 18243.7 18923.5 19249.8 19252.3 19290.3 59131.7 59456.4 59719.7 60059.0 60913.7 87959.0 88317.0 90502.5 92262.0 92607.6 6631.5 6678.6 8228.2 8233.4 8391.2 9168.3 12554.4 13222.7 13490.0 13731.2 9921.8 10359.6 10501.6 11734.6 11996.7 9038.3 10828.3 11545.2 11603.4 11673.9 10732.5 11602.9 11801.8 12029.0 12034.8 6686.6 8129.6 8239.7 8487.7 8522.3 9575.8 11609.1 11614.9 11718.0 11905.0 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5873.47 Median:4853.82 stddev:3312.15 (68.2%) stddev-sans-first:3303.68 05:45:00 INFO - PROCESS | 1638 | Values: 1309.7 1438.9 1537.8 1592.2 1698.2 8507.6 8738.6 9017.3 9480.7 9494.6 8935.0 9152.7 9198.6 9245.4 9272.4 2484.2 2505.1 2509.0 2512.6 2518.7 2453.1 2495.3 2501.3 2506.7 2513.1 2442.6 2493.8 2497.2 2501.9 2506.7 2436.3 2447.9 2455.4 2471.0 2482.3 1844.5 1949.8 2304.9 2435.4 2436.7 6958.4 9059.3 9153.6 9183.0 9264.0 5471.5 5635.1 5643.7 5650.1 5650.8 3336.9 3461.3 3721.9 3748.6 3803.5 1003.9 1007.9 1060.4 1081.9 1082.9 11550.7 11621.8 11663.8 11686.8 11757.9 4824.1 4883.5 4921.5 5003.6 5024.5 10258.7 10259.9 10273.0 10280.0 10310.5 5499.7 5548.8 5569.5 5583.0 5590.2 4673.9 4680.0 4786.3 5093.7 5101.4 3437.0 4082.0 4207.3 4241.4 4281.1 1298.2 1298.9 1307.3 1320.8 1322.4 705.4 809.6 865.8 950.6 954.5 5778.9 5861.9 5874.5 5897.2 6064.5 981.4 984.7 996.6 1011.4 1018.4 3494.0 3626.9 3855.8 3981.4 4001.6 10823.4 11073.5 11171.0 11190.9 11213.7 11052.5 11100.7 11126.0 11128.9 11197.8 7762.6 8405.2 8427.5 8574.2 8667.2 5592.9 5776.9 6006.3 6012.3 6049.3 10156.8 10245.4 10283.4 10402.9 10458.7 10121.6 10323.3 10642.3 10771.7 10802.2 6938.5 7061.9 7305.0 7360.6 7496.7 8646.0 8670.8 8807.7 8810.7 8816.3 7744.9 7795.6 7855.6 7856.9 7991.2 7758.5 7763.7 7793.8 7800.8 7845.8 7138.2 7149.3 7234.9 7244.1 7284.1 4993.9 5009.3 5059.3 5122.7 5243.3 5051.3 5084.9 5108.1 5275.8 5281.9 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4801.79 Median:5304.30 stddev:1506.58 (28.4%) stddev-sans-first:1472.52 05:45:00 INFO - PROCESS | 1638 | Values: 305.6 307.6 311.3 312.4 312.9 4936.7 4981.5 5678.6 5685.7 5784.4 4381.4 4511.0 4779.0 5108.7 5159.5 3585.6 4009.7 4138.0 4167.1 4203.5 4173.7 4182.2 4222.9 4244.3 4260.7 4245.2 4252.6 4285.8 4303.6 4368.4 3669.6 4084.6 4197.4 4243.1 4300.2 3480.3 3546.8 3617.9 3646.9 3687.1 5175.5 5451.3 5462.3 5475.5 5528.4 3832.3 4556.5 4883.2 4898.4 4994.8 4687.1 5999.4 6001.8 6078.0 6087.5 3116.4 4083.0 4095.9 4121.2 4133.3 5104.6 6130.9 6146.4 6257.2 6345.8 3442.8 4094.0 4135.7 4194.2 4223.2 3885.0 3906.1 4234.6 4246.7 4280.0 4574.7 4773.8 4973.7 5011.7 5042.6 4551.0 4906.4 5798.7 5938.8 6040.3 1427.9 1453.5 1454.9 1458.9 1462.5 764.4 822.9 887.5 904.6 912.8 4370.5 5410.2 5772.5 5774.9 5864.9 5276.7 6301.6 6355.6 6381.4 6424.6 4823.5 4990.9 5146.0 5331.9 5813.0 3196.8 3199.4 3271.9 3274.2 3280.6 5714.8 6042.4 6197.6 6632.4 6633.1 5469.4 5525.2 6342.6 6502.1 6506.7 5722.2 5880.7 5955.9 6169.7 6546.7 5870.9 5975.7 6131.0 6281.3 6324.6 4827.0 5366.5 6198.7 6224.4 6234.5 5789.0 6105.5 6408.6 6471.5 6500.9 4130.0 4142.5 4164.8 4180.7 4186.1 5411.8 5461.3 5656.3 6265.0 6350.6 5073.1 5721.6 5811.0 5988.5 6082.6 5501.9 5786.7 5831.5 6123.9 6125.3 4379.6 5673.2 5824.7 5938.5 5953.4 5468.4 6137.8 6181.3 6196.8 6198.5 5263.7 5942.9 6063.9 6067.9 6099.7 05:45:00 INFO - PROCESS | 1638 | 05:45:00 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:24905.02 Median:24409.89 stddev:39194.21 (160.6%) stddev-sans-first:39261.63 05:45:00 INFO - PROCESS | 1638 | Values: 587.3 716.4 782.4 784.7 838.8 16027.6 16413.7 16653.5 17012.7 17038.6 15244.7 15317.5 15328.7 15398.2 15400.6 687.9 690.3 713.4 859.2 885.0 847.6 852.1 852.1 852.9 854.2 885.9 910.7 911.4 912.2 912.6 904.2 904.7 905.2 905.6 905.8 657.7 671.4 676.2 676.3 678.3 15277.0 15388.3 15427.7 15430.5 15441.8 15186.9 15291.8 15309.8 15329.4 15340.8 11939.5 11988.2 12163.2 12285.8 12382.9 3164.6 3674.7 3926.0 3977.1 3991.1 124810.0 128629.0 129720.0 130247.0 132980.0 11280.0 11288.4 11539.0 11923.7 11938.5 23369.5 23577.9 24394.3 24425.5 24450.5 8224.0 8386.9 8630.9 8757.7 8791.0 4570.7 4626.0 4639.1 4702.3 4705.7 3345.4 3483.2 3488.0 3488.6 3496.2 545.8 628.0 628.2 635.8 636.1 467.0 542.5 553.5 569.6 668.7 7554.1 8545.7 9659.6 9816.7 9834.5 600.5 618.2 622.8 631.6 658.7 4080.3 4553.0 4610.1 4708.8 4732.1 129533.0 133074.0 134578.0 142888.3 175791.4 107720.4 114692.9 120986.0 132583.0 134580.0 80324.2 87915.0 115892.0 119178.0 125123.0 9453.4 10622.8 10724.8 10784.5 10787.2 56413.0 65979.7 66249.7 66479.0 67584.7 56677.7 68570.7 69715.2 71276.5 100449.5 13767.0 13849.2 13992.6 14329.1 14356.0 15410.2 15418.2 15425.4 15703.2 16175.0 14468.4 14891.0 15171.0 15271.8 15596.6 14452.3 14497.9 14520.5 14607.4 14954.9 13488.7 14070.0 14142.3 14142.8 14527.6 11010.7 11209.9 11313.7 11435.7 11902.8 11755.2 11852.8 12157.7 12208.3 12214.8 05:45:00 INFO - PROCESS | 1638 | -------- Summary: end -------- 05:45:00 INFO - PROCESS | 1638 | 05:45:01 INFO - TEST-INFO | 1638: exit 0 05:45:01 INFO - TEST-OK | dromaeo_css | took 1113232ms 05:45:01 INFO - TEST-START | kraken 05:45:01 INFO - operating with platform_type : mac_ 05:45:01 INFO - Initialising browser for kraken test... 05:45:01 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpVP4KRt/profile http://localhost:49241/getInfo.html) 05:45:03 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 05:45:03 INFO - PROCESS | 1651 | colorDepth:24 05:45:03 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 05:45:03 INFO - PROCESS | 1651 | __metrics 05:45:04 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 05:45:04 INFO - TEST-INFO | 1651: exit 0 05:45:04 INFO - Browser initialized. 05:45:04 INFO - Running cycle 1/1 for kraken test... 05:45:04 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpVP4KRt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:16 INFO - PROCESS | 1654 | RSS: Main: 174329856 05:45:16 INFO - PROCESS | 1654 | 05:45:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:20 INFO - PROCESS | 1654 | RSS: Main: 186183680 05:45:20 INFO - PROCESS | 1654 | 05:45:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:45:23 INFO - PROCESS | 1654 | RSS: Main: 193753088 05:45:23 INFO - PROCESS | 1654 | 05:45:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:45:27 INFO - PROCESS | 1654 | RSS: Main: 197537792 05:45:27 INFO - PROCESS | 1654 | 05:45:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:45:29 INFO - PROCESS | 1654 | RSS: Main: 198828032 05:45:29 INFO - PROCESS | 1654 | 05:45:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:32 INFO - PROCESS | 1654 | RSS: Main: 199008256 05:45:32 INFO - PROCESS | 1654 | 05:45:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:36 INFO - PROCESS | 1654 | RSS: Main: 200089600 05:45:36 INFO - PROCESS | 1654 | 05:45:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:39 INFO - PROCESS | 1654 | RSS: Main: 200183808 05:45:39 INFO - PROCESS | 1654 | 05:45:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:45:43 INFO - PROCESS | 1654 | RSS: Main: 200564736 05:45:43 INFO - PROCESS | 1654 | 05:45:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:45 INFO - PROCESS | 1654 | RSS: Main: 199688192 05:45:45 INFO - PROCESS | 1654 | 05:45:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:48 INFO - PROCESS | 1654 | RSS: Main: 199704576 05:45:48 INFO - PROCESS | 1654 | 05:45:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:51 INFO - PROCESS | 1654 | RSS: Main: 199749632 05:45:51 INFO - PROCESS | 1654 | 05:45:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:54 INFO - PROCESS | 1654 | RSS: Main: 200040448 05:45:54 INFO - PROCESS | 1654 | 05:45:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:58 INFO - PROCESS | 1654 | RSS: Main: 200118272 05:45:58 INFO - PROCESS | 1654 | 05:45:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:46:00 INFO - PROCESS | 1654 | RSS: Main: 201609216 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | __start_tp_report 05:46:00 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 05:46:00 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 05:46:00 INFO - PROCESS | 1654 | |i|pagename|runs| 05:46:00 INFO - PROCESS | 1654 | |0;ai-astar;105;107;169;170;116;119;117;120;116;116 05:46:00 INFO - PROCESS | 1654 | |1;audio-beat-detection;144;124;140;172;98;138;142;143;149;108 05:46:00 INFO - PROCESS | 1654 | |2;audio-dft;201;197;193;204;195;195;180;253;282;183 05:46:00 INFO - PROCESS | 1654 | |3;audio-fft;82;58;58;83;58;58;58;68;77;62 05:46:00 INFO - PROCESS | 1654 | |4;audio-oscillator;84;69;87;72;68;76;125;87;60;108 05:46:00 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;92;75;80;99;134;125;90;87;90;86 05:46:00 INFO - PROCESS | 1654 | |6;imaging-darkroom;124;133;104;152;89;149;150;131;105;102 05:46:00 INFO - PROCESS | 1654 | |7;imaging-desaturate;93;93;95;89;93;118;144;90;75;152 05:46:00 INFO - PROCESS | 1654 | |8;json-parse-financial;53;54;54;53;57;57;57;57;57;57 05:46:00 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;67;81;117;61;96;104;57;86;59;67 05:46:00 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;82;86;86;85;84;86;88;84;86;104 05:46:00 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;136;145;162;150;120;153;123;150;168;128 05:46:00 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;163;165;164;165;163;177;221;171;171;160 05:46:00 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;66;69;69;88;88;87;59;77;83 05:46:00 INFO - PROCESS | 1654 | __end_tp_report 05:46:00 INFO - PROCESS | 1654 | __start_cc_report 05:46:00 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,912 05:46:00 INFO - PROCESS | 1654 | __end_cc_report 05:46:00 INFO - PROCESS | 1654 | __startTimestamp1479476760151__endTimestamp 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | ------- Summary: start ------- 05:46:00 INFO - PROCESS | 1654 | Number of tests: 14 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:125.50 Median:118.00 stddev:23.69 (20.1%) stddev-sans-first:23.94 05:46:00 INFO - PROCESS | 1654 | Values: 105.0 107.0 169.0 170.0 116.0 119.0 117.0 120.0 116.0 116.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:143.50 stddev:21.10 (14.7%) stddev-sans-first:22.17 05:46:00 INFO - PROCESS | 1654 | Values: 144.0 124.0 140.0 172.0 98.0 138.0 142.0 143.0 149.0 108.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:208.30 Median:199.00 stddev:32.76 (16.5%) stddev-sans-first:34.64 05:46:00 INFO - PROCESS | 1654 | Values: 201.0 197.0 193.0 204.0 195.0 195.0 180.0 253.0 282.0 183.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.20 Median:65.00 stddev:10.57 (16.3%) stddev-sans-first:9.54 05:46:00 INFO - PROCESS | 1654 | Values: 82.0 58.0 58.0 83.0 58.0 58.0 58.0 68.0 77.0 62.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:74.00 stddev:19.83 (26.8%) stddev-sans-first:21.03 05:46:00 INFO - PROCESS | 1654 | Values: 84.0 69.0 87.0 72.0 68.0 76.0 125.0 87.0 60.0 108.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:95.80 Median:88.50 stddev:19.03 (21.5%) stddev-sans-first:20.14 05:46:00 INFO - PROCESS | 1654 | Values: 92.0 75.0 80.0 99.0 134.0 125.0 90.0 87.0 90.0 86.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:123.90 Median:141.00 stddev:22.82 (16.2%) stddev-sans-first:24.20 05:46:00 INFO - PROCESS | 1654 | Values: 124.0 133.0 104.0 152.0 89.0 149.0 150.0 131.0 105.0 102.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:104.20 Median:91.50 stddev:25.40 (27.8%) stddev-sans-first:26.61 05:46:00 INFO - PROCESS | 1654 | Values: 93.0 93.0 95.0 89.0 93.0 118.0 144.0 90.0 75.0 152.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:1.84 (3.2%) stddev-sans-first:1.69 05:46:00 INFO - PROCESS | 1654 | Values: 53.0 54.0 54.0 53.0 57.0 57.0 57.0 57.0 57.0 57.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:79.50 Median:67.00 stddev:20.83 (31.1%) stddev-sans-first:21.60 05:46:00 INFO - PROCESS | 1654 | Values: 67.0 81.0 117.0 61.0 96.0 104.0 57.0 86.0 59.0 67.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:6.15 (7.2%) stddev-sans-first:6.24 05:46:00 INFO - PROCESS | 1654 | Values: 82.0 86.0 86.0 85.0 84.0 86.0 88.0 84.0 86.0 104.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:150.00 stddev:16.29 (10.9%) stddev-sans-first:17.05 05:46:00 INFO - PROCESS | 1654 | Values: 136.0 145.0 162.0 150.0 120.0 153.0 123.0 150.0 168.0 128.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:168.00 stddev:17.94 (10.7%) stddev-sans-first:18.73 05:46:00 INFO - PROCESS | 1654 | Values: 163.0 165.0 164.0 165.0 163.0 177.0 221.0 171.0 171.0 160.0 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:80.00 stddev:10.57 (13.2%) stddev-sans-first:10.87 05:46:00 INFO - PROCESS | 1654 | Values: 68.0 66.0 69.0 69.0 88.0 88.0 87.0 59.0 77.0 83.0 05:46:00 INFO - PROCESS | 1654 | -------- Summary: end -------- 05:46:00 INFO - PROCESS | 1654 | 05:46:00 INFO - TEST-INFO | 1654: exit 0 05:46:00 INFO - TEST-OK | kraken | took 59419ms 05:46:00 INFO - SUITE-END | took 1172s 05:46:01 INFO - Completed test suite (00:19:33) 05:46:01 INFO - javascript benchmark 05:46:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7533.652274778602, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3615.4576813477975, 3628.9274214515726, 3638.981805090974, 3644.2529281497295, 3691.6492933171357, 6016.849578760533, 6044.24446944132, 6080.665563394012, 6085.056816193492, 6117.877642447154, 5549.6115271930985, 5776.942230577693, 6015.669138197398, 6051.394860513958, 6129.601575897575, 5360.115580929142, 5387.380451248097, 5401.972990135044, 5467.398586155519, 5524.475174858382, 5461.508464238218, 5498.615096943216, 5506.724663766816, 5509.669419834822, 5571.0, 5330.466953304658, 5379.838604841861, 5471.644343117685, 5486.478784515464, 5487.2317875497265, 5436.130219164915, 5441.2654291670715, 5459.863503412446, 5463.262459567987, 5476.123820188751, 5257.080010998098, 5389.622726409153, 5400.923132255667, 5424.349078110613, 5437.891242175135, 5956.16613674086, 6037.818865434044, 6053.243344581927, 6089.482393996515, 6111.419415155553, 6133.110698948627, 6207.224096987877, 6232.968835155841, 6374.139491168679, 6384.553081284312, 6482.546221764478, 6497.772577959749, 6508.8047358579315, 6512.348765123497, 6514.3811337922825, 5758.568107391962, 5770.278715160605, 6027.578069535134, 6078.75684972605, 6098.1157732128595, 6480.805575832733, 6485.092087107809, 6528.51036172289, 6615.338466153346, 6640.667966601747, 5438.45615438453, 5568.747031917786, 6222.844428889223, 6318.936810631927, 6347.587406818542, 5128.384593848762, 5272.7100009499845, 6317.1156038154695, 6341.397567231105, 6467.870642587122, 5230.476952304739, 6247.437730604177, 6335.334789847092, 6342.365763423713, 6347.809565713036, 6206.596571222856, 6342.5560210785725, 6360.1731774869895, 6375.362463753588, 6389.9361006389345, 5145.15105007677, 5162.638615296968, 5177.197534382177, 5184.326037615086, 5246.501582349671, 4646.8141274348645, 4662.906741865144, 4672.976635116871, 4680.08738296029, 4681.64887633422, 6040.879182416327, 6100.749346383981, 6163.0, 6227.906581401283, 6239.688015599202, 6277.5605707600025, 6301.275353334334, 6445.129907462527, 6466.64433456155, 6523.575967562093, 6153.784617538365, 6186.1648677428875, 6198.938010619926, 6210.968945155245, 6237.5321850860455, 5705.4579814917515, 5719.342275638355, 5728.914066289009, 5730.169125476783, 5732.541396688255, 6532.08550802888, 6599.769008084694, 6606.372394622503, 6625.304343043911, 6640.435562977008, 6481.189851268591, 6492.64290464029, 6495.642739649175, 6501.08984742127, 6528.37980391862, 6676.465882729467, 6679.833004174934, 6764.763233286812, 6770.695318710768, 6789.694463749044, 6239.812805615838, 6294.307626161027, 6314.62112273265, 6350.460210882126, 6420.101185834081, 6464.5798023128345, 6484.448821850196, 6493.935060649522, 6501.44737697301, 6502.837429064311, 6257.530685198537, 6296.307406185224, 6306.211723534559, 6336.081268216175, 6372.458341041063, 6177.938220617736, 6200.162977997912, 6202.658853763086, 6276.246850377801, 6326.715297811517, 4974.0, 6164.599301045418, 6300.117983482224, 6305.684715764285, 6307.905381419374, 6274.058891166362, 6307.558470907176, 6307.810765677037, 6318.115463835159, 6326.841828954313, 6151.98492248774, 6185.288691800501, 6262.279837818527, 6282.937170628235, 6295.653739044396], "value": 5918.883638628074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.45456179954834, 512.2828040742961, 530.8885134121834, 545.6862304175099, 546.3607579132415, 41112.79443602781, 42675.35986960198, 42723.57276427235, 42745.14509709804, 42814.0, 43738.12523749523, 44002.55997440025, 44062.33906491405, 44241.77879110608, 44374.55625443745, 10048.397096174216, 10300.330478518872, 10345.379277243352, 10385.324953877975, 10446.11208047313, 7921.524708517479, 9996.850047249298, 10024.599016039387, 10052.497375131214, 10059.24555658325, 10012.449315287657, 10053.447060411674, 10056.245781566375, 10097.596096156145, 10107.837598676137, 8473.195046470575, 9972.152367048773, 10015.699529014104, 10029.0, 10034.197264218845, 8980.685676001374, 9824.263180261438, 10050.547725352304, 10152.0, 10163.796724065478, 42169.0, 42439.1512169758, 42553.57446425527, 42829.92925176864, 42855.0, 3496.213351995806, 3986.421968814506, 4261.403403523509, 4265.253580623409, 4276.700630955803, 31368.529472057937, 31513.054608361555, 32950.01149965505, 33342.83328583366, 33466.49800252998, 3384.76306658534, 3407.267437500924, 3417.9316413671836, 3420.6579342065843, 3483.651634836521, 535569.0, 545575.0, 546097.0, 546551.0, 546836.0, 34509.0, 34810.825945870616, 61036.69481652652, 61458.0, 61514.69242653847, 36114.09714757152, 36302.81848590793, 36528.26943461116, 36683.26633467369, 36726.81636591853, 15898.682026359407, 16067.196640167946, 16069.598260043593, 16070.276837542338, 16151.919240403722, 13552.93223533876, 13583.320833958263, 13598.184108953297, 13621.591352259447, 13665.795013074812, 7917.129115797257, 7925.445218834626, 7955.801104972306, 7978.760637180894, 8027.478213916077, 2959.5708622249654, 3378.273671160712, 3421.110511267039, 3423.1613254752747, 3495.291149359267, 990.3708399682482, 1001.884783249921, 1061.098066643347, 1108.3017698849835, 1108.3848464102339, 30867.382652346827, 31065.534016989764, 31244.06267811969, 31321.90373336922, 31828.840855795574, 1063.2509521836535, 1086.9565217391216, 1100.2078503477483, 1134.3080720760329, 1200.6698158006618, 13769.869039288173, 14781.852181478047, 15729.921350393175, 15873.444429444913, 16254.67490650204, 768648.0, 774289.0, 774414.0, 776091.0, 779041.0, 56019.71990140023, 57619.42380576224, 57787.71106144526, 57903.13145302824, 57983.710081449324, 1393.9372728227254, 1422.4879043544315, 1429.0996672096512, 1437.9568612941628, 1440.6110350205386, 29935.55096673508, 30569.388612228075, 30647.0, 30789.92235271755, 30952.53571196479, 50447.49552504428, 50665.74667126641, 50936.23595645994, 50986.725331867, 51074.723131922, 627500.0, 635935.0, 645638.0, 649637.0, 651827.0, 26768.33079173036, 26879.731202687723, 26900.327491812863, 26936.0, 27250.04624838121, 49231.753841230566, 49277.260841086696, 49993.75015624639, 50132.0, 50602.493975061254, 40511.797441012604, 40959.79520102381, 41261.58738412698, 41280.761577152734, 41944.0, 40558.98602534842, 41026.79486602548, 41743.7912810434, 41991.79004105082, 42021.73934781962, 33957.49063764095, 34292.0, 38353.80823095867, 39602.60397396104, 40397.798011009756, 33677.49483757697, 35545.345585298266, 35826.283474329844, 36153.27693446169, 36164.4575331365, 21753.673694894274, 26791.866040669673, 27012.864935675196, 27019.59470607903, 27186.592201116604], "value": 19533.776811643518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.93269211541946, 383.3444809375967, 385.3756913799645, 389.846010825724, 409.3859211183225, 16763.580910477245, 17155.39956101535, 18555.721664175013, 19726.112324945378, 20960.685589716166, 17090.914545427288, 21083.94580270984, 21084.15663373467, 21437.035333409996, 21460.141594336208, 5768.394318596529, 5971.671558064305, 5991.101334799771, 6190.907136392958, 6243.87512249757, 6058.545609079315, 6130.2643682758135, 6167.167432396636, 6174.722137503801, 6175.351588083254, 5893.263342082239, 6155.8768824623485, 6212.720427580747, 6246.656433896134, 6286.811395658137, 6231.40801623845, 6233.096201050845, 6266.404691554295, 6338.3027866934835, 6747.257801641816, 5231.110711179109, 5931.881362372772, 6021.42796434338, 6040.697965101727, 6102.908456373158, 13100.0, 16379.344826206938, 19670.0, 24619.38451538708, 25009.499810003697, 2224.5439684864564, 2256.8420210585264, 2262.886855657227, 2441.121196369306, 2441.816863735227, 9865.753356166082, 9986.750331241705, 10162.03460671235, 10409.271351005433, 10428.478576071242, 1929.6719557675228, 1979.1885327015998, 2004.0781240629328, 2040.6020825938947, 2073.979260207409, 120976.0, 123800.0, 129832.0, 139085.0, 140404.29797851047, 9986.551949967214, 10957.83563246536, 11463.484143213574, 11535.90408911152, 11932.0, 12697.666744991828, 14030.579082627537, 14260.35828387725, 14638.121712697272, 14688.779668304984, 8618.310535157172, 8754.606042728092, 8782.209601135928, 8782.209601135928, 8869.246114080375, 8903.0, 9077.818443631091, 9105.317101217435, 9163.633454661738, 9239.0, 4492.752898590544, 4575.084983003413, 4600.171969045604, 4608.400907882021, 4635.930461043087, 1932.21745193197, 1932.9710054349196, 1951.7853036166011, 1958.4712127725434, 1960.8529360298035, 884.2616415293173, 929.2844509727472, 937.7889974755761, 955.1594596754811, 989.8218320702342, 20506.89746551258, 20580.0, 21890.233841815778, 21932.0, 22063.66904496434, 870.6125774030496, 952.8237276103943, 1007.1137399088755, 1008.7377281906611, 1039.2205845615788, 10994.505247263893, 11273.887261127447, 11325.830112548318, 11405.201635885409, 11537.538498460135, 664843.0, 681090.0, 691146.0, 709115.0, 713675.0, 112927.0, 123079.99999999821, 149200.0, 154078.22960885125, 155207.0, 893.5666201892207, 1019.9592016319413, 1044.3159730376615, 1055.7941201465794, 1057.3074636113358, 18243.726344104583, 18923.526911826764, 19249.807501924803, 19252.326168584033, 19290.324838630582, 59131.70434147802, 59456.40543594509, 59719.70140149271, 60059.0, 60913.69543152256, 87959.0, 88317.0, 90502.54748726478, 92262.0, 92607.61088583812, 6631.469482441296, 6678.632675202911, 8228.177182281725, 8233.423660343718, 8391.244787969112, 9168.266538677024, 12554.372281386077, 13222.735545288848, 13490.043943628316, 13731.244781536712, 9921.801563968536, 10359.63741269052, 10501.579936802442, 11734.589289375172, 11996.700082498008, 9038.276937845088, 10828.296160749525, 11545.191836571359, 11603.419829008684, 11673.883261167619, 10732.51703673321, 11602.94198529002, 11801.81981801813, 12029.0, 12034.75930481403, 6686.598804071771, 8129.552874591717, 8239.670413183645, 8487.660493580188, 8522.27560657351, 9575.808483830424, 11609.071274297867, 11614.941925290319, 11718.003969662674, 11905.0], "value": 9785.940391736192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6922223277531, 1438.9424423023079, 1537.8158817710364, 1592.1959410497698, 1698.2442812948243, 8507.617157227924, 8738.563071846398, 9017.323700722447, 9480.715578532647, 9494.57581362796, 8935.0, 9152.679656212034, 9198.632054717804, 9245.399049061807, 9272.397294175891, 2484.2050543826026, 2505.110685706566, 2509.034021901572, 2512.57286261336, 2518.672572565573, 2453.129139155601, 2495.25142457263, 2501.2746303572035, 2506.7117281512587, 2513.1078467144175, 2442.645816356627, 2493.8004959603277, 2497.2383423055962, 2501.9374515637073, 2506.7117281512587, 2436.3421876093357, 2447.865367404792, 2455.435249892517, 2471.0, 2482.342179322481, 1844.483544607512, 1949.8245157935853, 2304.896279667419, 2435.415500279938, 2436.6588677584973, 6958.373746362801, 9059.320550958639, 9153.588088536031, 9183.0, 9264.0, 5471.480209380103, 5635.09838425854, 5643.661380317194, 5650.0959846424785, 5650.830475085754, 3336.9499457507914, 3461.29043546075, 3721.9441708374397, 3748.5501739791125, 3803.5055442792536, 1003.8544411060428, 1007.8840933292691, 1060.4114716332433, 1081.9080378167787, 1082.8592283003238, 11550.711232219177, 11621.825672614917, 11663.766724665544, 11686.76626467466, 11757.941210293893, 4824.107540105022, 4883.536064073907, 4921.458639549646, 5003.5997120230295, 5024.547790698854, 10258.743531411774, 10259.897401025893, 10273.02406271403, 10280.0, 10310.484475776331, 5499.697516636624, 5548.805791797267, 5569.526590239794, 5582.967151077064, 5590.161475778666, 4673.859784206479, 4679.99380133273, 4786.2581299898575, 5093.668911520814, 5101.387833459934, 3436.9828150859585, 4082.040720430696, 4207.26372884744, 4241.427407299975, 4281.143771245764, 1298.2405292903568, 1298.9415476303589, 1307.2809954524973, 1320.8414990201238, 1322.418136020148, 705.3757424679093, 809.5749731390949, 865.7619154732499, 950.6245033211843, 954.5131982688879, 5778.855528611734, 5861.9413805861395, 5874.471297583153, 5897.233359663216, 6064.545159113084, 981.4062492192263, 984.670135504614, 996.5714742660725, 1011.4083261292079, 1018.4093225928943, 3494.021673931303, 3626.9093272667865, 3855.768653880776, 3981.3629819228786, 4001.559828418872, 10823.404712740874, 11073.50169242386, 11171.0, 11190.94404527972, 11213.719657008476, 11052.502637381176, 11100.722481937855, 11126.0, 11128.888711112948, 11197.776044479227, 7762.611869406507, 8405.201505856934, 8427.452215605967, 8574.228319451155, 8667.219950204511, 5592.888142237214, 5776.913346299725, 6006.339302676614, 6012.3386427493815, 6049.334573197033, 10156.847647285149, 10245.360742281198, 10283.382997020202, 10402.947985260025, 10458.68623941283, 10121.645742398981, 10323.277370583986, 10642.255042146975, 10771.676849694522, 10802.189835762192, 6938.548994315353, 7061.858762824612, 7304.96347518259, 7360.558366498028, 7496.700131994659, 8646.0, 8670.78323041929, 8807.735767926972, 8810.691625793066, 8816.294696424398, 7744.922550774646, 7795.571243581658, 7855.60721963888, 7856.882146767917, 7991.200879911962, 7758.534487930742, 7763.650635721293, 7793.844123117619, 7800.804979875548, 7845.803854903673, 7138.214796372291, 7149.285071492809, 7234.855302894018, 7244.094488188976, 7284.053073100675, 4993.850184494471, 5009.298698182184, 5059.291699162047, 5122.718250496258, 5243.265942767939, 5051.3433253676785, 5084.872429787794, 5108.106081435808, 5275.762590683506, 5281.894362112813], "value": 4697.1521588089745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.5569424334715, 307.63698835374265, 311.285599549035, 312.36433857100803, 312.9499280115182, 4936.728479933602, 4981.476944920785, 5678.602497825149, 5685.715714214288, 5784.363719990798, 4381.414965170548, 4510.9850283686155, 4778.972520908004, 5108.693478391299, 5159.509846564571, 3585.6055833858254, 4009.6591789697836, 4138.02756352257, 4167.124903770196, 4203.495580530325, 4173.728707634009, 4182.247195504808, 4222.936655950163, 4244.320908654616, 4260.70175087744, 4245.172191422674, 4252.554131595257, 4285.764282964436, 4303.612674859262, 4368.388425620416, 3669.559652841676, 4084.6323830855217, 4197.412362269285, 4243.133021470543, 4300.204462174492, 3480.3039392121677, 3546.769459985093, 3617.9095522612147, 3646.9270614587826, 3687.078230442389, 5175.473235395567, 5451.291332126838, 5462.289902312674, 5475.479829416239, 5528.44715528448, 3832.3485007548784, 4556.476005259405, 4883.218685010382, 4898.363212782351, 4994.825181118644, 4687.109449204674, 5999.400059993965, 6001.759929602855, 6077.969610151965, 6087.54343424245, 3116.439040972624, 4083.0, 4095.9385609215888, 4121.175764847043, 4133.256013917494, 5104.596236035083, 6130.877382452326, 6146.354632763585, 6257.177379894327, 6345.809625711236, 3442.759006869495, 4093.9500072446217, 4135.731177473454, 4194.224068547267, 4223.155368926227, 3884.980575097163, 3906.121122747416, 4234.581415225873, 4246.72396294246, 4279.957200428018, 4574.656900732459, 4773.809047638125, 4973.651844370932, 5011.724355160428, 5042.571381432619, 4551.043051487892, 4906.411230652345, 5798.6810725410505, 5938.792142275, 6040.275166979991, 1427.9000469967211, 1453.5130731204954, 1454.8836093112525, 1458.8687018168416, 1462.5466105507326, 764.4304992780415, 822.8642274024719, 887.5296093070683, 904.5974541329177, 912.7900582865846, 4370.5088099782815, 5410.242566040757, 5772.538196944234, 5774.942250577525, 5864.912026319608, 5276.709780962007, 6301.590396624297, 6355.5551111421755, 6381.425671689571, 6424.550281480345, 4823.517648235148, 4990.8770526631215, 5145.974270128625, 5331.893362132736, 5813.0, 3196.7602429817393, 3199.40810949975, 3271.871204434466, 3274.2141885947203, 3280.6063272407464, 5714.771324165241, 6042.3655516170165, 6197.628142311386, 6632.43624291931, 6633.137692100093, 5469.425710300361, 5525.226468294442, 6342.5560210785725, 6502.122213501211, 6506.707198176094, 5722.197507785035, 5880.735366908414, 5955.851103722355, 6169.722362493609, 6546.672666366662, 5870.911936321044, 5975.701214939322, 6131.0, 6281.277653069956, 6324.588901721373, 4826.95173048265, 5366.463353664602, 6198.675496688742, 6224.439800417984, 6234.537357743757, 5789.044807606698, 6105.481034111973, 6408.58344207625, 6471.4822814175695, 6500.869982600416, 4129.958700412957, 4142.523609784913, 4164.833406663821, 4180.728252663567, 4186.079062606222, 5411.834077064961, 5461.317335333083, 5656.349519805275, 6265.0, 6350.618962862059, 5073.068372011573, 5721.628094173865, 5810.970945145247, 5988.461038506555, 6082.635041897501, 5501.9174712380145, 5786.710664466844, 5831.504322132666, 6123.908141377794, 6125.264968203844, 4379.605835474823, 5673.177389278614, 5824.737886795019, 5938.495227905676, 5953.404659534185, 5468.414159893746, 6137.754489820357, 6181.289151747606, 6196.752129914753, 6198.473129784019, 5263.73681315925, 5942.881142377215, 6063.877642824976, 6067.938110830499, 6099.688566958125], "value": 4318.166033972074, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.251254650321, 716.4053835316688, 782.3897360059156, 784.6508303804806, 838.8238469921314, 16027.59931001724, 16413.671726565462, 16653.500394988154, 17012.659746805057, 17038.574035649115, 15244.695106097872, 15317.540473785777, 15328.693426131471, 15398.230088495558, 15400.61498462539, 687.9002544631026, 690.2579726793692, 713.3722324354561, 859.166608389864, 884.9601767920427, 847.5550336073549, 852.1393392673414, 852.1478521478522, 852.8720691896203, 854.239726643288, 885.8848349714528, 910.6630546697731, 911.389369122686, 912.192709452133, 912.5665308978215, 904.159132007233, 904.7059705595708, 905.1853332001251, 905.6332185464864, 905.8324210021134, 657.7237560224717, 671.3890359772583, 676.1615596660106, 676.2730065179951, 678.3081257117713, 15277.00699454543, 15388.30752616135, 15427.691446171126, 15430.5370838875, 15441.845581544154, 15186.924065379602, 15291.770623440658, 15309.846901530953, 15329.386824527006, 15340.846591534053, 11939.462724177432, 11988.160828741991, 12163.20939138962, 12285.754284914341, 12382.876171238262, 3164.604424446944, 3674.65090816372, 3926.0, 3977.1449138435373, 3991.1419044905197, 124810.0, 128629.0, 129720.0, 130247.0, 132980.0, 11280.041196498225, 11288.435578221057, 11539.0, 11923.701907452383, 11938.52245910154, 23369.532609348058, 23577.882110589337, 24394.268171954514, 24425.511489770106, 24450.51098978046, 8224.013118425828, 8386.916130838736, 8630.870536941951, 8757.737267881846, 8790.989036260784, 4570.7257564546235, 4625.976870115628, 4639.0721855628335, 4702.31816386622, 4705.7411842349, 3345.4480010797947, 3483.216276337854, 3487.982560087183, 3488.633693462201, 3496.1609213788506, 545.7735039958452, 627.9874402511924, 628.2241431831684, 635.8219698484339, 636.0840389838618, 467.04955415729506, 542.4981891750116, 553.4880235781966, 569.6297406685687, 668.6823758714669, 7554.131274903347, 8545.74362769118, 9659.613615455444, 9816.65641702537, 9834.508274586242, 600.4895838537295, 618.1994317359031, 622.8007037747877, 631.6084027902638, 658.6640813185214, 4080.3063479208604, 4552.9772351138035, 4610.147122782296, 4708.8116475341285, 4732.100900828831, 129533.0, 133074.0, 134578.0, 142888.2855585736, 175791.36312955315, 107720.38419423715, 114692.85307146989, 120986.0, 132583.0, 134580.0, 80324.19675803283, 87915.0, 115892.0, 119178.0, 125122.99999999818, 9453.43279403238, 10622.84065738999, 10724.839127413252, 10784.514696838503, 10787.190960678137, 56413.0, 65979.67010164919, 66249.66875165787, 66479.00281495879, 67584.6620766893, 56677.71661141833, 68570.65714671394, 69715.18577224927, 71276.50532231347, 100449.49775251077, 13767.0, 13849.16904985704, 13992.580222593338, 14329.068610540282, 14356.0, 15410.152441615819, 15418.152001640017, 15425.382984680487, 15703.214839257764, 16175.0, 14468.421263149356, 14891.0, 15171.0, 15271.770923435935, 15596.610084747972, 14452.277386130441, 14497.85502144965, 14520.491782787552, 14607.415703372171, 14954.925225374238, 13488.662783430493, 14070.0, 14142.292885355486, 14142.78785818234, 14527.564173074825, 11010.724731881766, 11209.887901120885, 11313.71715707114, 11435.656930292105, 11902.761944761229, 11755.235909665844, 11852.822207666719, 12157.723439039128, 12208.32854193028, 12214.755704885674], "value": 7965.7968256558825, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 169.0, 170.0, 116.0, 119.0, 117.0, 120.0, 116.0, 116.0], "value": 125.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 140.0, 172.0, 98.0, 138.0, 142.0, 143.0, 149.0, 108.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 197.0, 193.0, 204.0, 195.0, 195.0, 180.0, 253.0, 282.0, 183.0], "value": 208.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 83.0, 58.0, 58.0, 58.0, 68.0, 77.0, 62.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 87.0, 72.0, 68.0, 76.0, 125.0, 87.0, 60.0, 108.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 75.0, 80.0, 99.0, 134.0, 125.0, 90.0, 87.0, 90.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 133.0, 104.0, 152.0, 89.0, 149.0, 150.0, 131.0, 105.0, 102.0], "value": 123.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 95.0, 89.0, 93.0, 118.0, 144.0, 90.0, 75.0, 152.0], "value": 104.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 117.0, 61.0, 96.0, 104.0, 57.0, 86.0, 59.0, 67.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 86.0, 85.0, 84.0, 86.0, 88.0, 84.0, 86.0, 104.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 162.0, 150.0, 120.0, 153.0, 123.0, 150.0, 168.0, 128.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 165.0, 163.0, 177.0, 221.0, 171.0, 171.0, 160.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 69.0, 88.0, 88.0, 87.0, 59.0, 77.0, 83.0], "value": 75.4, "unit": "score"}]}]} 05:46:01 INFO - Return code: 0 05:46:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:46:01 ERROR - # TBPL SUCCESS # 05:46:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:01 INFO - 2016-11-18 05:46:01.455 screenresolution[1659:10510] starting screenresolution argv=screenresolution get 05:46:01 INFO - 2016-11-18 05:46:01.458 screenresolution[1659:10510] Display 0: 1600x1200x32@60 05:46:01 INFO - 2016-11-18 05:46:01.464 screenresolution[1660:10513] starting screenresolution argv=screenresolution list 05:46:01 INFO - Available Modes on Display 0 05:46:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:01 INFO - Intel Iris: 05:46:01 INFO - Chipset Model: Intel Iris 05:46:01 INFO - Type: GPU 05:46:01 INFO - Bus: Built-In 05:46:01 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:01 INFO - Vendor: Intel (0x8086) 05:46:01 INFO - Device ID: 0x0a2e 05:46:01 INFO - Revision ID: 0x0009 05:46:01 INFO - Displays: 05:46:01 INFO - Display: 05:46:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:01 INFO - Display Serial Number: 1600x1200 60 05:46:01 INFO - Main Display: Yes 05:46:01 INFO - Mirror: Off 05:46:01 INFO - Online: Yes 05:46:01 INFO - Rotation: Supported 05:46:01 INFO - Return code: 0 05:46:01 INFO - Running post-action listener: _resource_record_post_action 05:46:01 INFO - [mozharness: 2016-11-18 13:46:01.697591Z] Finished run-tests step (success) 05:46:01 INFO - Running post-run listener: _resource_record_post_run 05:46:01 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 38499328; Write bytes: 495279104; Read time: 377; Write time: 1505 05:46:01 INFO - TinderboxPrint: CPU usage
54.1% 05:46:01 INFO - TinderboxPrint: I/O read bytes / time
38,499,328 / 377 05:46:01 INFO - TinderboxPrint: I/O write bytes / time
495,279,104 / 1,505 05:46:01 INFO - TinderboxPrint: CPU idle
2,196.9 (45.9%) 05:46:01 INFO - TinderboxPrint: CPU system
966.3 (20.2%) 05:46:01 INFO - TinderboxPrint: CPU user
1,622.5 (33.9%) 05:46:01 INFO - TinderboxPrint: Swap in / out
233,848,832 / 0 05:46:01 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190239232; Write bytes: 185786368; Read time: 17419; Write time: 330 05:46:01 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 36561920; Write bytes: 298421248; Read time: 357; Write time: 1141 05:46:02 INFO - Running post-run listener: _upload_blobber_files 05:46:02 INFO - Blob upload gear active. 05:46:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:46:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:04 INFO - (blobuploader) - INFO - Done attempting. 05:46:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:46:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:46:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:05 INFO - (blobuploader) - INFO - Done attempting. 05:46:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:46:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:07 INFO - (blobuploader) - INFO - Done attempting. 05:46:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:07 INFO - Return code: 0 05:46:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc899c24b02d1ee35fc800f505a498cec18c2752867a4638c46ad315cf136410fe222ab89fae8fce46b096059d1e606d3aa9c01cfe3c181467b94c228386ce90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a71feb2b8fd7dd012647ebdab617c98b45aefdb5be56ef8cd58f63044bf2392c4e4f66d25214363e3dd180fd64c57ae63ddd647d51a025e53a0fc04e9f511b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96ec4639023da2c9f5c6092848a74709d5bc92a4f7cde3d74e5ca29d13054dcddcc30fb3e0f6a4c5fb288d1c6fa65c264d7454f129955895853a4e1d5a3ed3bf"} 05:46:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:07 INFO - Contents: 05:46:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc899c24b02d1ee35fc800f505a498cec18c2752867a4638c46ad315cf136410fe222ab89fae8fce46b096059d1e606d3aa9c01cfe3c181467b94c228386ce90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a71feb2b8fd7dd012647ebdab617c98b45aefdb5be56ef8cd58f63044bf2392c4e4f66d25214363e3dd180fd64c57ae63ddd647d51a025e53a0fc04e9f511b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96ec4639023da2c9f5c6092848a74709d5bc92a4f7cde3d74e5ca29d13054dcddcc30fb3e0f6a4c5fb288d1c6fa65c264d7454f129955895853a4e1d5a3ed3bf"} 05:46:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:07 INFO - Copying logs to upload dir... 05:46:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.357102 ========= master_lag: 1.31 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-18 05:46:09.230707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-11-18 05:46:09.236373) ========= 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.d09wc38ilG/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.m4a9TPSXUH/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-Beta/sha512/bc899c24b02d1ee35fc800f505a498cec18c2752867a4638c46ad315cf136410fe222ab89fae8fce46b096059d1e606d3aa9c01cfe3c181467b94c228386ce90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a71feb2b8fd7dd012647ebdab617c98b45aefdb5be56ef8cd58f63044bf2392c4e4f66d25214363e3dd180fd64c57ae63ddd647d51a025e53a0fc04e9f511b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96ec4639023da2c9f5c6092848a74709d5bc92a4f7cde3d74e5ca29d13054dcddcc30fb3e0f6a4c5fb288d1c6fa65c264d7454f129955895853a4e1d5a3ed3bf"} build_url:https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010971 build_url: 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc899c24b02d1ee35fc800f505a498cec18c2752867a4638c46ad315cf136410fe222ab89fae8fce46b096059d1e606d3aa9c01cfe3c181467b94c228386ce90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a71feb2b8fd7dd012647ebdab617c98b45aefdb5be56ef8cd58f63044bf2392c4e4f66d25214363e3dd180fd64c57ae63ddd647d51a025e53a0fc04e9f511b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96ec4639023da2c9f5c6092848a74709d5bc92a4f7cde3d74e5ca29d13054dcddcc30fb3e0f6a4c5fb288d1c6fa65c264d7454f129955895853a4e1d5a3ed3bf"}' ========= master_lag: 1.55 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-11-18 05:46:10.795651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-11-18 05:46:10.796121) ========= 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.d09wc38ilG/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.m4a9TPSXUH/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005141 ========= master_lag: 5.98 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-11-18 05:46:16.783202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 05:46:16.783543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 05:46:17.008181) ========= ========= Total master_lag: 8.92 =========