builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0009 starttime: 1486332146.51 results: success (0) buildid: 20170205125608 builduid: 160dc41d272c457d8646fb7530696d11 revision: b436cf72703fa77dd654350f09ac4bc4f2b66725 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.514301) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.514796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.515094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.549217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.549667) ========= 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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 --2017-02-05 14:02:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 56.7M=0s 2017-02-05 14:02:26 (56.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159924 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.840690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.841009) ========= 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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.019823 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:26.882859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 14:02:26.883207) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b436cf72703fa77dd654350f09ac4bc4f2b66725 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b436cf72703fa77dd654350f09ac4bc4f2b66725 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ok7id9vDbF/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.4EHJ8eQPmr/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 2017-02-05 14:02:26,972 truncating revision to first 12 chars 2017-02-05 14:02:26,973 Setting DEBUG logging. 2017-02-05 14:02:26,973 attempt 1/10 2017-02-05 14:02:26,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b436cf72703f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 14:02:28,175 unpacking tar archive at: mozilla-central-b436cf72703f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.447880 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 14:02:28.450442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:28.450824) ========= script_repo_revision: b436cf72703fa77dd654350f09ac4bc4f2b66725 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:28.455294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:28.455657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 14:02:28.492105) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-05 14:02:28.492622) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ok7id9vDbF/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.4EHJ8eQPmr/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:02:28 INFO - MultiFileLogger online at 20170205 14:02:28 in /builds/slave/test 14:02:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:02:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:02:28 INFO - {'append_to_log': False, 14:02:28 INFO - 'base_work_dir': '/builds/slave/test', 14:02:28 INFO - 'blob_upload_branch': 'Firefox', 14:02:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:02:28 INFO - 'branch': 'Firefox', 14:02:28 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:28 INFO - 'config_files': ('talos/mac_config.py',), 14:02:28 INFO - 'default_actions': ('clobber', 14:02:28 INFO - 'read-buildbot-config', 14:02:28 INFO - 'download-and-extract', 14:02:28 INFO - 'populate-webroot', 14:02:28 INFO - 'create-virtualenv', 14:02:28 INFO - 'install', 14:02:28 INFO - 'run-tests'), 14:02:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:28 INFO - 'download_minidump_stackwalk': True, 14:02:28 INFO - 'download_symbols': 'ondemand', 14:02:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:28 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:28 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:28 INFO - 'installer_path': 'installer.exe', 14:02:28 INFO - 'log_level': 'info', 14:02:28 INFO - 'log_name': 'talos', 14:02:28 INFO - 'log_to_console': True, 14:02:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:02:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:02:28 INFO - 'opt_config_files': (), 14:02:28 INFO - 'pip_index': False, 14:02:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:02:28 INFO - 'cmd': ('bash', 14:02:28 INFO - '-c', 14:02:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:02:28 INFO - 'enabled': True, 14:02:28 INFO - 'halt_on_failure': False, 14:02:28 INFO - 'name': 'check_screen_resolution'},), 14:02:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:02:28 INFO - 'cmd': ('bash', 14:02:28 INFO - '-c', 14:02:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:02:28 INFO - 'enabled': True, 14:02:28 INFO - 'halt_on_failure': False, 14:02:28 INFO - 'name': 'check_screen_resolution'},), 14:02:28 INFO - 'run_cmd_checks_enabled': True, 14:02:28 INFO - 'sps_profile': False, 14:02:28 INFO - 'sps_profile_interval': 0, 14:02:28 INFO - 'suite': 'dromaeojs-e10s', 14:02:28 INFO - 'system_bits': '32', 14:02:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:28 INFO - 'title': 't-yosemite-r7-0009', 14:02:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:28 INFO - 'use_talos_json': True, 14:02:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:02:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:28 INFO - 'work_dir': 'build'} 14:02:28 INFO - [mozharness: 2017-02-05 22:02:28.711310Z] Running clobber step. 14:02:28 INFO - Running pre-action listener: _resource_record_pre_action 14:02:28 INFO - Running main action method: clobber 14:02:28 INFO - rmtree: /builds/slave/test/build 14:02:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:02:29 INFO - Running post-action listener: _resource_record_post_action 14:02:29 INFO - [mozharness: 2017-02-05 22:02:29.088404Z] Finished clobber step (success) 14:02:29 INFO - [mozharness: 2017-02-05 22:02:29.088535Z] Running read-buildbot-config step. 14:02:29 INFO - Running pre-action listener: _resource_record_pre_action 14:02:29 INFO - Running main action method: read_buildbot_config 14:02:29 INFO - Using buildbot properties: 14:02:29 INFO - { 14:02:29 INFO - "project": "", 14:02:29 INFO - "product": "firefox", 14:02:29 INFO - "script_repo_revision": "production", 14:02:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:02:29 INFO - "repository": "", 14:02:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:02:29 INFO - "buildid": "20170205125608", 14:02:29 INFO - "pgo_build": "False", 14:02:29 INFO - "basedir": "/builds/slave/test", 14:02:29 INFO - "buildnumber": 83, 14:02:29 INFO - "slavename": "t-yosemite-r7-0009", 14:02:29 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:02:29 INFO - "platform": "yosemite_r7", 14:02:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:02:29 INFO - "branch": "mozilla-central", 14:02:29 INFO - "repo_path": "mozilla-central", 14:02:29 INFO - "revision": "b436cf72703fa77dd654350f09ac4bc4f2b66725", 14:02:29 INFO - "stage_platform": "macosx64", 14:02:29 INFO - "builduid": "160dc41d272c457d8646fb7530696d11", 14:02:29 INFO - "slavebuilddir": "test" 14:02:29 INFO - } 14:02:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 14:02:29 INFO - Running post-action listener: _resource_record_post_action 14:02:29 INFO - [mozharness: 2017-02-05 22:02:29.091676Z] Finished read-buildbot-config step (success) 14:02:29 INFO - [mozharness: 2017-02-05 22:02:29.091826Z] Running download-and-extract step. 14:02:29 INFO - Running pre-action listener: _resource_record_pre_action 14:02:29 INFO - Running main action method: download_and_extract 14:02:29 INFO - mkdir: /builds/slave/test/build/tests 14:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:29 INFO - trying https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 14:02:29 INFO - Downloading https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 14:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 14:02:30 INFO - Downloaded 1199 bytes. 14:02:30 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 14:02:30 INFO - Using the following test package requirements: 14:02:30 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 14:02:30 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 14:02:30 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 14:02:30 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'jsshell-mac.zip'], 14:02:30 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 14:02:30 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 14:02:30 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 14:02:30 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 14:02:30 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 14:02:30 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:02:30 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 14:02:30 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:02:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 14:02:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:02:30 INFO - Fetch https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 14:02:32 INFO - Expected file size: 34850898 14:02:32 INFO - Obtained file size: 34850898 14:02:39 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:02:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 14:02:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:02:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 14:02:40 INFO - Expected file size: 34850898 14:02:40 INFO - Obtained file size: 34850898 14:02:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 14:02:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:02:46 INFO - Fetch https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 14:02:48 INFO - Expected file size: 14403454 14:02:48 INFO - Obtained file size: 14403454 14:02: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')]} 14:02:49 INFO - trying https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:02:49 INFO - Downloading https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 14:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 14:02:51 INFO - Downloaded 70286584 bytes. 14:02:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:02:51 INFO - mkdir: /builds/slave/test/properties 14:02:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:51 INFO - Contents: 14:02:51 INFO - build_url:https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:02:51 INFO - Running post-action listener: _resource_record_post_action 14:02:51 INFO - Running post-action listener: set_extra_try_arguments 14:02:51 INFO - [mozharness: 2017-02-05 22:02:51.888414Z] Finished download-and-extract step (success) 14:02:51 INFO - [mozharness: 2017-02-05 22:02:51.888538Z] Running populate-webroot step. 14:02:51 INFO - Running pre-action listener: _resource_record_pre_action 14:02:51 INFO - Running main action method: populate_webroot 14:02:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:51 INFO - '--tppagecycles', 14:02:51 INFO - '7'], 14:02:51 INFO - 'tests': ['tsvgm']}}, 14:02:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:02:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:02:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:02:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:02:51 INFO - 'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:02:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:02:51 INFO - 'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['damp', 'tps']}, 14:02:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:02:51 INFO - 'tests': ['damp', 'tps']}, 14:02:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['dromaeo_dom']}, 14:02:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['basic_compositor_video']}, 14:02:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:02:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['a11yr', 14:02:51 INFO - 'ts_paint', 14:02:51 INFO - 'tpaint', 14:02:51 INFO - 'sessionrestore', 14:02:51 INFO - 'sessionrestore_no_auto_restore', 14:02:51 INFO - 'tabpaint']}, 14:02:51 INFO - 'other-e10s': {'tests': ['a11yr', 14:02:51 INFO - 'ts_paint', 14:02:51 INFO - 'tpaint', 14:02:51 INFO - 'sessionrestore', 14:02:51 INFO - 'sessionrestore_no_auto_restore', 14:02:51 INFO - 'tabpaint']}, 14:02:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:02:51 INFO - 'ts_paint', 14:02:51 INFO - 'tpaint', 14:02:51 INFO - 'sessionrestore', 14:02:51 INFO - 'sessionrestore_no_auto_restore', 14:02:51 INFO - 'tabpaint']}, 14:02:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:02:51 INFO - 'ts_paint', 14:02:51 INFO - 'tpaint', 14:02:51 INFO - 'sessionrestore', 14:02:51 INFO - 'sessionrestore_no_auto_restore', 14:02:51 INFO - 'tabpaint']}, 14:02:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['a11yr', 14:02:51 INFO - 'ts_paint', 14:02:51 INFO - 'tpaint', 14:02:51 INFO - 'sessionrestore', 14:02:51 INFO - 'sessionrestore_no_auto_restore', 14:02:51 INFO - 'tabpaint']}, 14:02:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['a11yr', 14:02:51 INFO - 'ts_paint', 14:02:51 INFO - 'tpaint', 14:02:51 INFO - 'sessionrestore', 14:02:51 INFO - 'sessionrestore_no_auto_restore', 14:02:51 INFO - 'tabpaint']}, 14:02:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['tsvgx', 14:02:51 INFO - 'tsvgr_opacity', 14:02:51 INFO - 'tart', 14:02:51 INFO - 'tscrollx', 14:02:51 INFO - 'cart', 14:02:51 INFO - 'tsvg_static']}, 14:02:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:02:51 INFO - 'tsvgr_opacity', 14:02:51 INFO - 'tart', 14:02:51 INFO - 'tscrollx', 14:02:51 INFO - 'cart', 14:02:51 INFO - 'tsvg_static']}, 14:02:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:02:51 INFO - 'talos_options': ['--disable-e10s'], 14:02:51 INFO - 'tests': ['tp5o']}, 14:02:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:02:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:02:51 INFO - 'talos_options': ['--disable-e10s', 14:02:51 INFO - '--xperf_path', 14:02:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:51 INFO - 'tests': ['tp5n']}, 14:02:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:02:51 INFO - 'talos_options': ['--xperf_path', 14:02:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:51 INFO - 'tests': ['tp5n']}}, 14:02:51 INFO - 'talos.zip': {'path': '', 14:02:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:51 INFO - Running post-action listener: _resource_record_post_action 14:02:51 INFO - [mozharness: 2017-02-05 22:02:51.906811Z] Finished populate-webroot step (success) 14:02:51 INFO - [mozharness: 2017-02-05 22:02:51.906944Z] Running create-virtualenv step. 14:02:51 INFO - Running pre-action listener: _resource_record_pre_action 14:02:51 INFO - Running main action method: create_virtualenv 14:02:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:51 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 14:02:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:52 INFO - Using real prefix '/tools/python27' 14:02:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:52 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:55 INFO - Installing pip.................done. 14:02:55 INFO - Return code: 0 14:02:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:02:55 INFO - Reading from file tmpfile_stdout 14:02:55 INFO - Output received: 14:02:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:02:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:55 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')]} 14:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:55 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')]} 14:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:55 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:02:55 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 14:02:55 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 14:02:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:02:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:55 INFO - 'HOME': '/Users/cltbld', 14:02:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:55 INFO - 'LOGNAME': 'cltbld', 14:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:55 INFO - 'MOZ_NO_REMOTE': '1', 14:02:55 INFO - 'NO_EM_RESTART': '1', 14:02:55 INFO - 'PAGER': '/bin/cat', 14:02:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:55 INFO - 'PWD': '/builds/slave/test', 14:02:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:55 INFO - 'SHELL': '/bin/bash', 14:02:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:02:55 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:02:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:55 INFO - 'USER': 'cltbld', 14:02:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:55 INFO - 'XPC_FLAGS': '0x0', 14:02:55 INFO - 'XPC_SERVICE_NAME': '0', 14:02:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:56 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 14:02:56 INFO - Cleaning up... 14:02:56 INFO - Return code: 0 14:02:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:56 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:02:56 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 14:02:56 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 14:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:56 INFO - 'HOME': '/Users/cltbld', 14:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:56 INFO - 'LOGNAME': 'cltbld', 14:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:56 INFO - 'MOZ_NO_REMOTE': '1', 14:02:56 INFO - 'NO_EM_RESTART': '1', 14:02:56 INFO - 'PAGER': '/bin/cat', 14:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:56 INFO - 'PWD': '/builds/slave/test', 14:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:56 INFO - 'SHELL': '/bin/bash', 14:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:02:56 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:56 INFO - 'USER': 'cltbld', 14:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:56 INFO - 'XPC_FLAGS': '0x0', 14:02:56 INFO - 'XPC_SERVICE_NAME': '0', 14:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:56 INFO - Downloading/unpacking psutil>=3.1.1 14:02:56 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 14:02:56 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 14:02:56 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 14:02:56 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 14:02:56 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 14:02:56 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 14:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:00 INFO - Installing collected packages: psutil 14:03:00 INFO - Running setup.py install for psutil 14:03:00 INFO - building 'psutil._psutil_osx' extension 14:03:00 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 14:03:00 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 14:03:00 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 14:03:01 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 14:03:01 INFO - building 'psutil._psutil_posix' extension 14:03:01 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 14:03:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:03:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:03:01 INFO - ^ 14:03:01 INFO - 1 warning generated. 14:03:01 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 14:03:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:01 INFO - Successfully installed psutil 14:03:01 INFO - Cleaning up... 14:03:01 INFO - Return code: 0 14:03:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:03:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:01 INFO - 'HOME': '/Users/cltbld', 14:03:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:01 INFO - 'LOGNAME': 'cltbld', 14:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:01 INFO - 'MOZ_NO_REMOTE': '1', 14:03:01 INFO - 'NO_EM_RESTART': '1', 14:03:01 INFO - 'PAGER': '/bin/cat', 14:03:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:01 INFO - 'PWD': '/builds/slave/test', 14:03:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:01 INFO - 'SHELL': '/bin/bash', 14:03:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:01 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:01 INFO - 'USER': 'cltbld', 14:03:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:01 INFO - 'XPC_FLAGS': '0x0', 14:03:01 INFO - 'XPC_SERVICE_NAME': '0', 14:03:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:03:04 INFO - Installing collected packages: mozsystemmonitor 14:03:04 INFO - Running setup.py install for mozsystemmonitor 14:03:04 INFO - Successfully installed mozsystemmonitor 14:03:04 INFO - Cleaning up... 14:03:04 INFO - Return code: 0 14:03:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03: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==2.5.1'] in /builds/slave/test/build 14:03: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==2.5.1 14:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:04 INFO - 'HOME': '/Users/cltbld', 14:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PAGER': '/bin/cat', 14:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:04 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - 'XPC_FLAGS': '0x0', 14:03:04 INFO - 'XPC_SERVICE_NAME': '0', 14:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 INFO - Downloading/unpacking jsonschema==2.5.1 14:03:04 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 14:03:04 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 14:03:04 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 14:03:04 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 14:03:04 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 14:03:04 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 14:03:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:03:07 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 14:03:07 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 14:03:07 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 14:03:07 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 14:03:07 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 14:03:07 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 14:03:07 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:07 INFO - warning: no files found matching '*.txt' 14:03:07 INFO - no previously-included directories found matching 'build' 14:03:07 INFO - no previously-included directories found matching 'dist' 14:03:07 INFO - no previously-included directories found matching '.git*' 14:03:07 INFO - Installing collected packages: jsonschema, functools32 14:03:08 INFO - Running setup.py install for functools32 14:03:08 INFO - warning: no files found matching '*.txt' 14:03:08 INFO - no previously-included directories found matching 'build' 14:03:08 INFO - no previously-included directories found matching 'dist' 14:03:08 INFO - no previously-included directories found matching '.git*' 14:03:08 INFO - Successfully installed jsonschema functools32 14:03:08 INFO - Cleaning up... 14:03:08 INFO - Return code: 0 14:03:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03:08 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 14:03:08 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 14:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:08 INFO - 'HOME': '/Users/cltbld', 14:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:08 INFO - 'LOGNAME': 'cltbld', 14:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:08 INFO - 'MOZ_NO_REMOTE': '1', 14:03:08 INFO - 'NO_EM_RESTART': '1', 14:03:08 INFO - 'PAGER': '/bin/cat', 14:03:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:08 INFO - 'PWD': '/builds/slave/test', 14:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:08 INFO - 'SHELL': '/bin/bash', 14:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:08 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:08 INFO - 'USER': 'cltbld', 14:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:08 INFO - 'XPC_FLAGS': '0x0', 14:03:08 INFO - 'XPC_SERVICE_NAME': '0', 14:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:03:08 INFO - Cleaning up... 14:03:08 INFO - Return code: 0 14:03:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03:08 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 14:03:08 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 14:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:08 INFO - 'HOME': '/Users/cltbld', 14:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:08 INFO - 'LOGNAME': 'cltbld', 14:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:08 INFO - 'MOZ_NO_REMOTE': '1', 14:03:08 INFO - 'NO_EM_RESTART': '1', 14:03:08 INFO - 'PAGER': '/bin/cat', 14:03:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:08 INFO - 'PWD': '/builds/slave/test', 14:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:08 INFO - 'SHELL': '/bin/bash', 14:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:08 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:08 INFO - 'USER': 'cltbld', 14:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:08 INFO - 'XPC_FLAGS': '0x0', 14:03:08 INFO - 'XPC_SERVICE_NAME': '0', 14:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:08 INFO - Downloading/unpacking blobuploader==1.2.4 14:03:08 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 14:03:08 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 14:03:08 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 14:03:08 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 14:03:08 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 14:03:08 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 14:03:11 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:11 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 14:03:11 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 14:03:11 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 14:03:11 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 14:03:11 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 14:03:11 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 14:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:03:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:12 INFO - Downloading docopt-0.6.1.tar.gz 14:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:12 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:12 INFO - Running setup.py install for blobuploader 14:03:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:03:12 INFO - Running setup.py install for requests 14:03:13 INFO - Running setup.py install for docopt 14:03:13 INFO - Successfully installed blobuploader requests docopt 14:03:13 INFO - Cleaning up... 14:03:13 INFO - Return code: 0 14:03:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:13 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03:13 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 14:03:13 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 14:03:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:13 INFO - 'HOME': '/Users/cltbld', 14:03:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:13 INFO - 'LOGNAME': 'cltbld', 14:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:13 INFO - 'MOZ_NO_REMOTE': '1', 14:03:13 INFO - 'NO_EM_RESTART': '1', 14:03:13 INFO - 'PAGER': '/bin/cat', 14:03:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:13 INFO - 'PWD': '/builds/slave/test', 14:03:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:13 INFO - 'SHELL': '/bin/bash', 14:03:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:13 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:13 INFO - 'USER': 'cltbld', 14:03:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:13 INFO - 'XPC_FLAGS': '0x0', 14:03:13 INFO - 'XPC_SERVICE_NAME': '0', 14:03:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:13 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-BIjPWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:13 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-I2h1KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-xpq_Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-jbYMjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-sOdIIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-olYJdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mYqmRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-V7OWhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-_JdNyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-tKYMjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1skerH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:14 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-QWxKCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-lbbrYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-yfXTyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-TeLQYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-PpAiOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-J_x890-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:15 INFO - Running setup.py install for manifestparser 14:03:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:03:15 INFO - Running setup.py install for mozcrash 14:03:15 INFO - Running setup.py install for mozdebug 14:03:15 INFO - Running setup.py install for mozdevice 14:03:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Running setup.py install for mozfile 14:03:16 INFO - Running setup.py install for mozhttpd 14:03:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Running setup.py install for mozinfo 14:03:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Running setup.py install for mozInstall 14:03:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:03:16 INFO - Running setup.py install for mozleak 14:03:16 INFO - Running setup.py install for mozlog 14:03:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for moznetwork 14:03:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozprocess 14:03:17 INFO - Running setup.py install for mozprofile 14:03:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozrunner 14:03:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozscreenshot 14:03:17 INFO - Running setup.py install for moztest 14:03:17 INFO - Running setup.py install for mozversion 14:03:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:18 INFO - Cleaning up... 14:03:18 INFO - Return code: 0 14:03:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:18 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')]} 14:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:18 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')]} 14:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:18 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03:18 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 14:03:18 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 14:03:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:18 INFO - 'HOME': '/Users/cltbld', 14:03:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:18 INFO - 'LOGNAME': 'cltbld', 14:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:18 INFO - 'MOZ_NO_REMOTE': '1', 14:03:18 INFO - 'NO_EM_RESTART': '1', 14:03:18 INFO - 'PAGER': '/bin/cat', 14:03:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:18 INFO - 'PWD': '/builds/slave/test', 14:03:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:18 INFO - 'SHELL': '/bin/bash', 14:03:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:18 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:18 INFO - 'USER': 'cltbld', 14:03:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:18 INFO - 'XPC_FLAGS': '0x0', 14:03:18 INFO - 'XPC_SERVICE_NAME': '0', 14:03:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:18 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-O3iiTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:18 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)) 14:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:18 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-U0H2jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:18 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-7nYBUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:18 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)) 14:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:18 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-AZofW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 14:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:18 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-HFkuf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:18 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)) 14:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:18 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-83HQHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qnKef2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mqcR79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-RTEAFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-7RwUp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-3BCez6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-AuHrNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-N9Wgew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-xi1GAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:19 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-GojaPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:20 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)) 14:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:20 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-TYKEPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:20 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1jOpU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:20 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)) 14:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:20 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)) 14:03:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:20 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 14:03:20 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 14:03:20 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 14:03:20 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 14:03:20 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 14:03:20 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 14:03:22 INFO - Downloading blessings-1.6.tar.gz 14:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:22 INFO - Installing collected packages: blessings 14:03:22 INFO - Running setup.py install for blessings 14:03:23 INFO - Successfully installed blessings 14:03:23 INFO - Cleaning up... 14:03:23 INFO - Return code: 0 14:03:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:03:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:23 INFO - Reading from file tmpfile_stdout 14:03:23 INFO - Current package versions: 14:03:23 INFO - blessings == 1.6 14:03:23 INFO - blobuploader == 1.2.4 14:03:23 INFO - docopt == 0.6.1 14:03:23 INFO - functools32 == 3.2.3-2 14:03:23 INFO - jsonschema == 2.5.1 14:03:23 INFO - manifestparser == 1.1 14:03:23 INFO - mozInstall == 1.12 14:03:23 INFO - mozcrash == 1.0 14:03:23 INFO - mozdebug == 0.1 14:03:23 INFO - mozdevice == 0.49 14:03:23 INFO - mozfile == 1.2 14:03:23 INFO - mozhttpd == 0.7 14:03:23 INFO - mozinfo == 0.9 14:03:23 INFO - mozleak == 0.1 14:03:23 INFO - mozlog == 3.4 14:03:23 INFO - moznetwork == 0.27 14:03:23 INFO - mozprocess == 0.24 14:03:23 INFO - mozprofile == 0.28 14:03:23 INFO - mozrunner == 6.13 14:03:23 INFO - mozscreenshot == 0.1 14:03:23 INFO - mozsystemmonitor == 0.3 14:03:23 INFO - moztest == 0.8 14:03:23 INFO - mozversion == 1.4 14:03:23 INFO - psutil == 3.1.1 14:03:23 INFO - requests == 1.2.3 14:03:23 INFO - wsgiref == 0.1.2 14:03:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:23 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')]} 14:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:23 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')]} 14:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:23 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03:23 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 14:03:23 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 14:03:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:23 INFO - 'HOME': '/Users/cltbld', 14:03:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:23 INFO - 'LOGNAME': 'cltbld', 14:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:23 INFO - 'MOZ_NO_REMOTE': '1', 14:03:23 INFO - 'NO_EM_RESTART': '1', 14:03:23 INFO - 'PAGER': '/bin/cat', 14:03:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:23 INFO - 'PWD': '/builds/slave/test', 14:03:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:23 INFO - 'SHELL': '/bin/bash', 14:03:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:23 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:23 INFO - 'USER': 'cltbld', 14:03:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:23 INFO - 'XPC_FLAGS': '0x0', 14:03:23 INFO - 'XPC_SERVICE_NAME': '0', 14:03:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 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)) 14:03:23 INFO - Cleaning up... 14:03:23 INFO - Return code: 0 14:03:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:03:23 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')]} 14:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:23 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')]} 14:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:23 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 0x10799db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972ac64b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, '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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:03:23 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 14:03:23 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 14:03:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:23 INFO - 'HOME': '/Users/cltbld', 14:03:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:23 INFO - 'LOGNAME': 'cltbld', 14:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:23 INFO - 'MOZ_NO_REMOTE': '1', 14:03:23 INFO - 'NO_EM_RESTART': '1', 14:03:23 INFO - 'PAGER': '/bin/cat', 14:03:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:23 INFO - 'PWD': '/builds/slave/test', 14:03:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:23 INFO - 'SHELL': '/bin/bash', 14:03:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:23 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:23 INFO - 'USER': 'cltbld', 14:03:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:23 INFO - 'XPC_FLAGS': '0x0', 14:03:23 INFO - 'XPC_SERVICE_NAME': '0', 14:03:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:03:24 INFO - Cleaning up... 14:03:24 INFO - Return code: 0 14:03:24 INFO - Running post-action listener: _resource_record_post_action 14:03:24 INFO - Running post-action listener: _start_resource_monitoring 14:03:24 INFO - Starting resource monitoring. 14:03:24 INFO - [mozharness: 2017-02-05 22:03:24.105403Z] Finished create-virtualenv step (success) 14:03:24 INFO - [mozharness: 2017-02-05 22:03:24.106391Z] Running install step. 14:03:24 INFO - Running pre-action listener: _resource_record_pre_action 14:03:24 INFO - Running main action method: install 14:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:24 INFO - Reading from file tmpfile_stdout 14:03:24 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:03:24 INFO - Reading from file tmpfile_stdout 14:03:24 INFO - Output received: 14:03:24 INFO - Usage: mozinstall [options] installer 14:03:24 INFO - Options: 14:03:24 INFO - -h, --help show this help message and exit 14:03:24 INFO - -d DEST, --destination=DEST 14:03:24 INFO - Directory to install application into. [default: 14:03:24 INFO - "/builds/slave/test"] 14:03:24 INFO - --app=APP Application being installed. [default: firefox] 14:03:24 INFO - mkdir: /builds/slave/test/build/application 14:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:03:46 INFO - Reading from file tmpfile_stdout 14:03:46 INFO - Output received: 14:03:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:03:46 INFO - Running post-action listener: _resource_record_post_action 14:03:46 INFO - [mozharness: 2017-02-05 22:03:46.891581Z] Finished install step (success) 14:03:46 INFO - [mozharness: 2017-02-05 22:03:46.891706Z] Running run-tests step. 14:03:46 INFO - Running pre-action listener: _resource_record_pre_action 14:03:46 INFO - Running main action method: run_tests 14:03:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:03:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:03:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:03:46 INFO - 2017-02-05 14:03:46.906 screenresolution[2031:21559] starting screenresolution argv=screenresolution get 14:03:46 INFO - 2017-02-05 14:03:46.908 screenresolution[2031:21559] Display 0: 1600x1200x32@60 14:03:46 INFO - 2017-02-05 14:03:46.914 screenresolution[2032:21561] starting screenresolution argv=screenresolution list 14:03:46 INFO - Available Modes on Display 0 14:03:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:03:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:03:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:03:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:03:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:03:47 INFO - Intel Iris: 14:03:47 INFO - Chipset Model: Intel Iris 14:03:47 INFO - Type: GPU 14:03:47 INFO - Bus: Built-In 14:03:47 INFO - VRAM (Dynamic, Max): 1536 MB 14:03:47 INFO - Vendor: Intel (0x8086) 14:03:47 INFO - Device ID: 0x0a2e 14:03:47 INFO - Revision ID: 0x0009 14:03:47 INFO - Displays: 14:03:47 INFO - Display: 14:03:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:03:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:03:47 INFO - Display Serial Number: 1600x1200 60 14:03:47 INFO - Main Display: Yes 14:03:47 INFO - Mirror: Off 14:03:47 INFO - Online: Yes 14:03:47 INFO - Rotation: Supported 14:03:47 INFO - Return code: 0 14:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:47 INFO - Python 2.7.3 14:03:47 INFO - Return code: 0 14:03:47 INFO - grabbing minidump binary from tooltool 14:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:47 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 0x10777bd30>, '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 0x1076a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107770be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:47 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 14:03:47 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 14:03:47 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 14:03:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:47 INFO - Return code: 0 14:03:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:03:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:03:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 14:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --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 14:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ok7id9vDbF/Render', 14:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:03:47 INFO - 'HOME': '/Users/cltbld', 14:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:03:47 INFO - 'LOGNAME': 'cltbld', 14:03:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:47 INFO - 'MOZ_NO_REMOTE': '1', 14:03:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:47 INFO - 'NO_EM_RESTART': '1', 14:03:47 INFO - 'PAGER': '/bin/cat', 14:03:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:47 INFO - 'PWD': '/builds/slave/test', 14:03:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:03:47 INFO - 'SHELL': '/bin/bash', 14:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EHJ8eQPmr/Listeners', 14:03:47 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:03:47 INFO - 'USER': 'cltbld', 14:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:47 INFO - 'XPC_FLAGS': '0x0', 14:03:47 INFO - 'XPC_SERVICE_NAME': '0', 14:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:03:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 14:03:47 INFO - mozversion application_buildid: 20170205125608 14:03:47 INFO - mozversion application_changeset: b436cf72703fa77dd654350f09ac4bc4f2b66725 14:03:47 INFO - mozversion application_display_name: Nightly 14:03:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:47 INFO - mozversion application_name: Firefox 14:03:47 INFO - mozversion application_remotingname: firefox 14:03:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:03:47 INFO - mozversion application_vendor: Mozilla 14:03:47 INFO - mozversion application_version: 54.0a1 14:03:47 INFO - mozversion platform_buildid: 20170205125608 14:03:47 INFO - mozversion platform_changeset: b436cf72703fa77dd654350f09ac4bc4f2b66725 14:03:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:03:47 INFO - mozversion platform_version: 54.0a1 14:03:47 INFO - using testdate: 1486332227 14:03:47 INFO - actual date: 1486332227 14:03:47 INFO - starting webserver on 'localhost:49299' 14:03:47 INFO - SUITE-START | Running 2 tests 14:03:47 INFO - TEST-START | dromaeo_css 14:03:47 INFO - operating with platform_type : mac_ 14:03:47 INFO - Initialising browser for dromaeo_css test... 14:03:47 INFO - TEST-INFO | started process 2042 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpXgVAfm/profile http://localhost:49299/getInfo.html) 14:03:50 INFO - PROCESS | 2042 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 14:03:50 INFO - PROCESS | 2042 | 2017-02-05 14:03:50.571 plugin-container[2045:21727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d33, name = 'com.apple.tsm.portname' 14:03:50 INFO - PROCESS | 2042 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:03:50 INFO - PROCESS | 2042 | 2017-02-05 14:03:50.574 plugin-container[2045:21727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9313, name = 'com.apple.CFPasteboardClient' 14:03:50 INFO - PROCESS | 2042 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:03:50 INFO - PROCESS | 2042 | 2017-02-05 14:03:50.574 plugin-container[2045:21727] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:03:50 INFO - PROCESS | 2042 | __metrics Screen width/height:1600/1200 14:03:50 INFO - PROCESS | 2042 | colorDepth:24 14:03:50 INFO - PROCESS | 2042 | Browser inner width/height: 1024/689 14:03:50 INFO - PROCESS | 2042 | __metrics 14:03:50 ERROR - PROCESS | 2042 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 14:03:50 INFO - PROCESS | 2042 | 1486332230776 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpXgVAfm/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpXgVAfm/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpXgVAfm/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpXgVAfm/profile/extensions/talos-powers@TalosPowersService.js:55:9 14:03:51 INFO - TEST-INFO | 2042: exit 0 14:03:51 INFO - Browser initialized. 14:03:51 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:51 INFO - TEST-INFO | started process 2046 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpXgVAfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:53 INFO - PROCESS | 2046 | 2017-02-05 14:03:53.991 plugin-container[2047:21843] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 14:03:53 INFO - PROCESS | 2046 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:03:53 INFO - PROCESS | 2046 | 2017-02-05 14:03:53.991 plugin-container[2047:21843] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 14:03:53 INFO - PROCESS | 2046 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:03:53 INFO - PROCESS | 2046 | 2017-02-05 14:03:53.991 plugin-container[2047:21843] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:04:03 INFO - PROCESS | 2046 | RSS: Main: 232665088 14:04:03 INFO - PROCESS | 2046 | 14:07:06 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49299/tests/dromaeo/cssquery-ext.html) 14:07:08 INFO - PROCESS | 2046 | RSS: Main: 256827392 14:07:08 INFO - PROCESS | 2046 | 14:08:51 INFO - PROCESS | 2046 | ************************* 14:08:51 INFO - PROCESS | 2046 | A coding exception was thrown and uncaught in a Task. 14:08:51 INFO - PROCESS | 2046 | 14:08:51 ERROR - PROCESS | 2046 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:08:51 INFO - PROCESS | 2046 | Full stack: 14:08:51 INFO - PROCESS | 2046 | ************************* 14:10:10 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-ext.html (next: http://localhost:49299/tests/dromaeo/cssquery-jquery.html) 14:10:11 INFO - PROCESS | 2046 | RSS: Main: 262123520 14:10:11 INFO - PROCESS | 2046 | 14:13:12 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49299/tests/dromaeo/cssquery-mootools.html) 14:13:13 INFO - PROCESS | 2046 | RSS: Main: 274522112 14:13:13 INFO - PROCESS | 2046 | 14:16:15 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49299/tests/dromaeo/cssquery-prototype.html) 14:16:15 INFO - PROCESS | 2046 | RSS: Main: 268468224 14:16:15 INFO - PROCESS | 2046 | 14:19:18 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49299/tests/dromaeo/cssquery-yui.html) 14:19:19 INFO - PROCESS | 2046 | RSS: Main: 273436672 14:19:19 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-yui.html (next: http://localhost:49299/tests/dromaeo/cssquery-dojo.html) 14:22:22 INFO - PROCESS | 2046 | RSS: Main: 275812352 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | __start_tp_report 14:22:22 INFO - PROCESS | 2046 | _x_x_mozilla_page_load 14:22:22 INFO - PROCESS | 2046 | _x_x_mozilla_page_load_details 14:22:22 INFO - PROCESS | 2046 | |i|pagename|runs| 14:22:22 INFO - PROCESS | 2046 | |0;dojo.html;3302.785318954268;3332.5334453176542;3336.666333366662;3354.5135955286482;3355.7986520808754;5418.349798024243;5487.286652735143;5509.035918714229;5541.002619528488;5566.777328906849;5436.809711660093;5523.696196709179;5566.248556444879;5598.972005139979;5647.124695672167;4980.900381992358;5053.6715113517685;5123.846284611468;5133.435322114565;5169.508896654812;4949.752512374385;5116;5172.120739474299;5193.195054766517;5203.739813009353;3748.512693349861;4922.212446008657;4970.502949705036;5088.109580823379;5129.820456284012;5022.6233032522705;5034.672746271481;5096.133657278272;5133.6149788765615;5138.845834624967;4976.676516026447;5038.345015148007;5075.187969924795;5079.746012699387;5138.614603904722;5405.945940540583;5429.212764149216;5555.611107222496;5585.162225666142;5600.6079574429805;4932;6033.668148251844;6109.040306147832;6123.557162997608;6153.169322141498;6184.19605451293;6195.163652906845;6212.192414986023;6216.7824126155365;6229.626222426669;5756.769729210869;5775.364709881952;5775.768969241268;5782.681952492611;5818.41815818419;6062.454379105901;6166.568340216231;6195.690215489208;6229.96885015572;6230.158928544589;5975.312839023481;6078.361772013964;6107.097787096137;6114.023656277693;6138.817583427401;6182.907256391158;6212.968935155295;6245.469135123474;6289.591176573508;6291.370862913672;5909.8227053188475;5965.701714914237;6052.546059045501;6080.0575910733905;6128.571000030044;6154.415330543591;6163.876722465526;6190.938090619036;6194.690265486708;6212.844678883064;4967.726775027336;4973.179425394842;4974.801007959713;4981.327520784647;4982.950170498321;4323.416338794285;4348.760818154969;4376.518582955872;4382.386465894777;4498;5525.475079867406;5585.3297604287745;5619.578531610146;5626.578006649518;5649.915251271234;5179.766910489037;6152.446279834837;6220.875582488325;6248.843778905472;6264.614769661255;4557.794899229542;5357.812476563302;5418.241446197536;5545.251391062155;5606.103023516218;5342.9465705342445;5375.75809088592;5378.596605254622;5423.376311724123;5440.700761458079;6233.75064997395;6250.843728906813;6251.156093927261;6271.090691849565;6272.059191121369;5947.613405128653;6115.816525504242;6134.35589263121;6150.415710507495;6160.199174107516;6062.727177277121;6116.39664026098;6149.323574406722;6164.352742961924;6231.345708700521;6076;6121.390971446752;6133.76314253068;6135.325114237341;6144.402455361727;6136.825445958321;6139.907901381573;6163.630182189083;6204.5967012144065;6220;5782.335031471434;5826.7086645666695;5928.911066334094;5977.043673012297;6035.909461358171;6041.063635136561;6042.697865106639;6055.091736239599;6062.878742425215;6071.392860713893;5300.469953004668;5667.291588551431;5701.800436984851;5864.970675146597;5894.263217097863;6039.094135879654;6049.304330002106;6098.451139397475;6137.3248942617165;6142.539309551712;5894.70526473666;5905.734241959036;5931.258592675916;5939.762409503572;5942.702864856827 14:22:22 INFO - PROCESS | 2046 | |1;ext.html;439.8174757475648;454.84080571799853;460.82718980382356;488.3943909552156;493.36109737889427;37853.86438406849;38757;38777.61222387775;38805.223895522075;39080.80459597702;39835.40246896299;40224.798876005654;40485;40705.38941915874;40863.38704919429;8998.730038098867;9124.543772811367;10578.841317380207;10904.890951090467;10959.287646303004;10788.838167427495;10866.511007004703;10886.0746836519;10889.727756806104;10912.345259284468;10703.83944240833;10842.457877106153;10847.457627118652;10869.402182879938;10880.401577913211;10808.081313088396;10852.728681782939;10888.455577221146;10891.564337426493;10920.453977301182;9004.909950900472;10781.137508999262;10793.892061079367;10800.081993030602;10829.241953063289;36248.27503449943;36550;36602.26795464102;36611.4508282376;36684;3718.1076541629814;3732.234891847165;3735.14091758897;3736.6263373662687;3748.250349930025;26919.26511382359;27270.04554840571;27513.724862751318;27676.30809229765;28305.716942830513;2629.53983052965;3072.554479600468;3100.5969224000737;3109.70457806508;3225.080851957181;338505;385202.2219666679;434111;437798;442131;45698.543014569426;46872.7656361716;51033.74483127561;52719;54122.7293863536;57401.42598573961;57575.424245757844;57991.420085799444;58002.41997580055;58009;13538.661533461742;13751.174929504261;13773.862261377459;13927.860721392859;13937.024408291321;10391.84412233817;10435.68692939213;10444.582216711246;10469.424181670081;10520.158387328995;13892.93053534726;17512;17516.737248941277;17545.29818807259;17567;7100;7921.247481489249;7925.365970722443;7931;7971.40214483916;773.9922600774033;847.2332539052168;863.5690531154779;881.3478026260522;884.3323290915317;28632.14103576896;29232.415351692845;29311.560326595118;30370.54444183339;30443.695563044086;1027.4143738069379;1030.7114008077601;1041.8280983637615;1075.2043487818958;1125.5441546173813;15427.768583471257;15456.92271538635;15530.378784848706;15805.446809361847;15837.445689401045;578362;580331;580660;581152.0942395261;582337;57067;57168.71415642895;57832.71083644555;57996.710016449644;58057.419425806045;1357.7148798752175;1391.7216556688702;1402.3759427054863;1402.5792262321263;1414.5473448496589;24793.00827966861;25127.623085653366;28101.297467563476;29008.854955725088;29769;48841.755791220814;49026;49268;49458.752706236235;49463.752681236365;480712;482959;487100;489255;489439;25089.372765681004;26067.348316291485;26067.95728170852;26082.478350433266;26135.869320653273;44547.554524455634;44767.88080298019;45967;46236;46393.07213855771;37324.440133398566;37397.439038413904;37774.43338349982;38603.61396386113;38778.4183237246;36721.63278367289;36913.41606087548;37097.072573185884;38221.044473888374;38308.425373619975;35956.92129236127;36822.44766328561;36948;36979.260414792094;37165.442518361706;30845.537316939815;33304.1673958153;33414.665853341154;33440.498392523645;33494.81314835646;21978.45053873602;23970.88014559916;24285.028598855846;24688;25256.494870102862 14:22:22 INFO - PROCESS | 2046 | |2;jquery.html;386.08497860071634;387.1946351588696;397.46739369245205;401.77299825598544;420.50800563340886;19401.805981940193;19632.607347853034;20430.591388172266;20771.376858694246;20791.272305469312;12113.757724845498;12284.815727764068;12511.249325040504;16869.240884160212;20774;4503.144402563519;4729.4797572267025;4818.542238487338;5266.7893284268675;5806.448387403211;5966.612170208944;5970.641761494303;6118.663473508956;6149.815505534819;6153.846153846167;5918.2898052233795;6004.519638428916;6122.510199184077;6130.969345153268;6160.106784516242;6093.908591371133;6106.694665266741;6131.724072416752;6131.816045518642;6145.293291271494;5807.82576522705;5944.940550594482;6016.69916504173;6022.006368949118;6024.21685180928;13692;13880.652983675387;16201.270942807601;25746;26376.604350934558;2545.2618740565213;2594.3514121469634;2633.1310667479684;2633.2231991562535;2633.302174923647;10061.094501494827;10091.394516329045;10140.290179687425;10530.684079477627;10587.682369528926;1779.1904683369166;1799.658064967665;1852.4164888060352;1858.1173942377397;1865.4310435317223;121678;132128;132208.6779132206;133382;135650;12002.879971200351;12179;12242.204256723284;12311;12537.247765134121;16069.67860642804;16181.59546011359;16192.75710864338;16202.189890505428;16202.918985404998;8275.420720549624;8466.280366168945;8479.279261262738;8499.61751721174;8594.914050859412;7904.0910295315625;8040.195980401913;8145;8147.144549822302;8157.2250636189465;4846.684965477303;4932.4327702314695;4933.235348520985;4938.135826230396;5032.72320022395;2045.5170001748613;2086.1968142265337;2094.628018647788;2101.2120454829437;2104.316097268363;815.571824791989;901.833160865242;943.0239701908491;1027.6762819711766;1059.5179193466954;20202.696959545618;21266.57466850685;21603.459913501974;21719.67420488694;21814.890925545587;1031.8039572481205;1037.9377237365782;1064.084886997182;1070.1011150633506;1072.5656109275756;10725.356478611307;11291.378974156336;11422;11474.655760327036;11475.8278625819;335084;405367;658021;666173;666680;101919;135618;138963.30518347342;160623;163260;972.2902281334665;978.8776402949632;993.9950300248453;998.9051040151174;1000.8798944126752;15672.754009101332;15693.136877471848;15780.210989450712;18267.08664566793;19949.301774437827;47665.52334476611;57006.429935700115;61325;61884;62601.74796504135;71544.64227678828;89744;90405.09594903966;91015.63476547989;91241.08758912326;6607.438367738796;8116.391270654606;8133.552654604054;8587.65649374018;8608.139186081342;12183.695407614881;12477.251364918135;12914;13216.933915330363;13236.007299452773;10951.397673127736;11227.989480946753;11303.830442543533;11355.943220283845;11356.772864542829;10612.734681633021;10867.728306792393;10988.890111098786;11330.716732081764;11343.659690209306;10445.477726113815;10493.422861742372;10942.507587158438;11255.606053788078;11418.714532136763;6941.791746247621;7575.6969721210535;7598.278163574451;7751.186125456746;8691.913080869363;9060.501672408082;9421.528923553931;11439.942800286279;11455.312681239153;11470.541178352772 14:22:22 INFO - PROCESS | 2046 | |3;mootools.html;1259.9748005039899;1302.6157283601337;1381.52337443582;1438.7410266152092;1456.5775924981756;7761.922380776191;7955.681772729084;8257.463264887778;8625.784355391119;8709.303255739542;8345.415820892526;8573.356998225143;8575.571221438919;8580.356473264499;8589.226969572737;1781.1450503758203;1893.3751861885544;1905.3712274949235;2243.349428665685;2285.5771682238837;2121.819645330149;2265.796078352948;2305.400595845084;2310.0297874892585;2316.339843144696;2020.7676117246485;2152.719132116396;2269.4212975691175;2288.496530763229;2294.609916314222;2252.5044490212126;2275.2150508074687;2275.2719129878446;2276.146445083077;2279.213671283413;1838.4760343302094;1965.9508512287307;2031.2281333093479;2306.261996161229;2316.860988340705;8157.143499932481;8474.237318641352;8474.703385381483;8489.575521223976;8558.058613552505;5060.671056381323;5152.716600586966;5216.8695782605355;5218.191180367049;5224.164133738584;3371.342588195303;3456.997470733484;3463.497792820027;3517.6130625631417;3551.6448355164275;1214.2107630040457;1216.1669256559285;1238.851337839456;1261.7728808814409;1266.803645434959;9189.44863308197;10747.247692661516;10909.672709818718;11060.004599586076;11060.723481912935;4462.799174037176;4676.275177347517;4723.220668589644;4735.786889589976;4754.667173297905;9584.520773961274;9662.178714809179;9679.93520712721;9683.806323873483;9700.417974921527;5188.45521220274;5241.816536421207;5273.499017593323;5280.498352656491;5280.735963201824;4578.35902973584;4729.95270047302;4786.138495070921;4802.663813533089;4802.679263202577;3771.6427232979386;3823.866164684223;3872.5546562145714;3909.7849618270698;3918.549366822852;1254.7553227120807;1275.0883118570266;1276.2916581297468;1283.8972882169403;1283.9550615728406;729.2160927003492;870.3646338173169;876.9693060742843;888.0320450708758;888.7733627924838;5120.18077107661;5396.2984811974975;5525.4474552544425;5537.169424586264;5598.552115830724;577.1371799160282;584.1354794903482;595.3659352789266;595.553334998751;601.6239850093691;3621.7826930383735;3783.564890037626;3789.3558095123894;4040.1919616076902;4041.81811818463;10019.248556358303;10199.54102065409;10237.9488102559;10244.436555989492;10251.38491690501;10011.249156313306;10062.798744025078;10167.542460589291;10180.134688551409;10188.184945204366;7764.456488045896;7785.104712958082;7985.640646170937;8004.439689221815;8024.398170137147;4739.4075740532435;5592.440755924375;5715.228444160151;5801.100829371454;5893.970530147321;8900.154485323885;9053.185213330831;9321.627134914528;9482.95258523703;9506.667266645634;9220.492872892055;9390.67132650354;9394.436333819993;9489.762755931157;9529.61881524759;7111.7866464006165;7228.241034691492;7324.450666199949;7348.77953661391;7354.926450735424;7984.640691169027;8079;8099.947006889067;8127.268545830903;8131.878021829795;7290.270972902879;7359.190489046307;7370.44721645868;7415.3326200642205;7494.063242094739;7202.639868006474;7204.783856484314;7210.459215558959;7213.60325182099;7318.3047610476915;6369.554131210771;6376.808695739135;6408.9038664421005;6445.581037232565;6456.096146539394;4958.801647934187;5009.574186194214;5023.09584274834;5044.924326135184;5080.11098057831;4898.2897479864505;4911.140550403594;5061.898762024665;5138.229265610188;5142.125838607521 14:22:22 INFO - PROCESS | 2046 | |4;prototype.html;320.29854618385735;336.8551522845177;339.7808413573245;372.94219395993616;373.4044199501794;5124.436312005681;5530.4746049125315;5553.805616803413;5562.944370556298;5582.358028826686;4030.1335212929216;4601.769911504428;4764.380630518028;5417.51242388186;5474.124140137579;3179.9841000794963;3846.9230615387673;4020.6984476164403;4104.917901641966;4149.875503734893;3455.8272086395705;3465.3935561276676;3902.69259797968;4136.627703506684;4142.958570414303;3535.4166562517153;3597.622249663774;3848.3650197717484;4122.2992091344395;4130.421740956269;3245.3996010738088;4100.528439229497;4131.380292956081;4144.295469770132;4188.4136220929095;3333.7166340861054;3733.2720119576693;3739.626037396266;3751.3247615429214;3753.399456087013;4400.493943196541;4747.928781068286;5288.603354748409;5333.226682131108;5359.222912677679;4729.787159577792;4928.975355123237;4975.203967365241;4999.925001124986;5009.44896061433;5110.488951104897;5704.743286552115;5752.194692743019;5777.364489906107;5779.711014449303;3877.1664092220026;4220.978895105505;4224.598663126998;4237.555056719062;4254.553271906436;5249.2126181073145;5279.841604751864;5510.752016159283;5658.462446067617;5947.494462970652;4082.3876418537457;4205.243056249843;4239.27932251518;4252.575387245308;4263;4320.092780516064;4321.762303073361;4327.891802704958;4338.110687309094;4341.175176716414;4372.753765176909;4465.650761928554;4674.929876051862;4954.232094025432;4983.8504844854715;5245.790168393298;5531.8893622128135;5783.16144159103;5786.363500014995;5815.429833944811;1279.5969269680022;1330.7538105450328;1407.190865252484;1420.6164335629321;1439.6544829240906;929.2426672262085;941.4304345870787;1006.4514839412537;1007.8891321954579;1014.7666036811574;4430.136123455895;4842.322074909515;5081.822136225288;5182.305201295306;5210.358736997833;4836.927446088312;5002.1496345621335;5194.454717188551;5333.573314134937;5813.767449302065;3896.9088655176597;4460.104455606354;4942.616067501105;5090.567301779391;5092.541671249532;2965.976738025378;3013.382256637384;3014.7889647724887;3022.531507616323;3030.636323641177;5067.670601410897;5308.840734777963;5582.051051321285;5775.306963164363;5923.229980102559;5621.409751975983;5789.45000224978;5857.238558987305;6059.454649081604;6091.634501929899;5957.527626035234;6011.789587364421;6165.872773893089;6171.21034899874;6173.425776427072;5057.620678449204;5515.61390702663;5516.9448305516435;5595.804146854841;6010.158577799024;4843.612510999182;4925.556699897026;5407;5834.15404766315;5948.672822994777;4909.656324057281;5431.565474762088;6122.2959359674205;6212.844678882883;6222.346653601307;3358.833552358764;3916.099297161612;3985.8007099644324;3988.282109220252;4014.4781178446615;4630.930536042029;5628.324601047901;5826.504747096375;5895.764169433346;5919.437653422918;4565.908681826411;5076.847694569169;5731.598788084794;5794.82615521535;5830.7959221427045;5329.973350133225;5589.776408943597;5655.539840169539;5814.16853691086;5825.475707186373;5137.126688463045;5512.476314750093;5578.470045345685;5642.266505354278;5694.829155125353;5779.0062428462115;5806.187133801355;5820.0105981982315;5820.330661973927;5825.50483208932;5459.808906688247;5610.803621873378;5686.9715651421475;5691.971540142273;5706.457886500942 14:22:22 INFO - PROCESS | 2046 | |5;yui.html;618.7586841131962;698.9510734248602;723.2875617516746;785.685725709716;822.8642274024786;13797.448102075918;14555.781663275046;14641.682248597624;15136.318865651045;15504.457343992963;13825.585232443018;14063.156210627369;14107.717845643081;14307.499237526688;14326.498572549963;870.4733636150133;887.6626881784913;890.1410139215656;892.857142857143;894.217559635319;872.1365847810654;884.8495755721543;886.898006729228;902.9277657787361;910.7586489580267;944.1927152284801;949.4255975135047;949.8575213717928;952.8142012307603;953.6948176583496;913.3743385780762;936.3679516326487;947.6162154327509;949.4018768176074;949.7578117580008;683.9008343790173;700.7967689370076;703.6903762344552;705.4638474759169;705.5061456980135;14574.927125364411;15109.39562417502;15304;15327.46353877609;15360.692786144215;14185.858141418661;14341.13953162803;14393.352299146563;14446.78329825043;14465.059771114844;10498.52756625946;11589.072874170046;11670.708232294175;11787.233829801036;12310;3648.5986541480415;3699.3711069118312;3703.8888833335045;3719.962800372016;3848.8845334640005;96947;97077;97864.51067744616;98254.50872745662;98269.50865245699;10862.891371086345;10982;11117.27737697047;11202.21584489078;11549.960503554721;22684;22795.974181161888;22851;23058.192963246205;23129.42176445569;7656.540607563453;7680.884786728204;7700.845983080307;7751.7674469766;7829.569373684388;3656.0494271489606;4024.7786371749835;4173.979130104391;4212.7472351659;4274.636655884223;3590.7666001709804;3658.5426821647293;3682.815859207029;3685.870994515179;3697.1126929536717;596.2189531713469;661.5435349608755;674.2145400608334;676.8409423785406;690.6995456976232;673.2863165045068;702.7154002628944;704.6934583456213;710.4210068793916;717.4153065251803;9790.06994335537;9878.259130565237;10500;10561.89438105609;10636.361818290927;643.4161719223878;700.6461736822973;707.3916431868589;717.3579646216607;725.7314793526324;4095.894108590664;4188.560201178832;4705.458872229738;4978.253262010728;5017.498250174954;77019.07452313625;97045.02954970501;100905;102092;102301.48849255707;74702;77967.61016194883;80256.59871700604;84839.5758021206;92034;54764.72617636966;67158.65682686417;73175;75973;76935;8928.687495937611;9294.25645948309;10589.52347144365;10606.628767993392;10843.566257349934;40986.1802763949;42006.789966049975;49279;50229;50906;60132;60698;60889.39110608837;61566.384336157855;63031;12557.497700091893;12825.935870320589;12900.870991290343;13143.408546615234;13309.86690133125;14427.855721443071;14470.927645361706;14786.482473113389;14828.555143345717;15401.229938503255;13415.597532074053;13522.25627590492;13670.17978921268;14068.788968165281;14514.274286285854;13547;13670.070175613215;13814.516491922734;13817.513899920412;14312.57062288133;13365.933170334087;13447.731045378841;13451;13874.167549947035;13924.373403196678;10364.637237696645;10842;11170.609028683957;11266.66200014001;11466.31202127875;10247.847951930178;10986.242399595167;11103.611373601885;11115.499802509068;11136.49885755159 14:22:22 INFO - PROCESS | 2046 | __end_tp_report 14:22:22 INFO - PROCESS | 2046 | __start_cc_report 14:22:22 INFO - PROCESS | 2046 | _x_x_mozilla_cycle_collect,413 14:22:22 INFO - PROCESS | 2046 | __end_cc_report 14:22:22 INFO - PROCESS | 2046 | __startTimestamp1486333342516__endTimestamp 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | ------- Summary: start ------- 14:22:22 INFO - PROCESS | 2046 | Number of tests: 6 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | [#0] dojo.html Cycles:165 Average:5628.89 Median:5864.97 stddev:656.93 (11.2%) stddev-sans-first:633.09 14:22:22 INFO - PROCESS | 2046 | Values: 3302.8 3332.5 3336.7 3354.5 3355.8 5418.3 5487.3 5509.0 5541.0 5566.8 5436.8 5523.7 5566.2 5599.0 5647.1 4980.9 5053.7 5123.8 5133.4 5169.5 4949.8 5116.0 5172.1 5193.2 5203.7 3748.5 4922.2 4970.5 5088.1 5129.8 5022.6 5034.7 5096.1 5133.6 5138.8 4976.7 5038.3 5075.2 5079.7 5138.6 5405.9 5429.2 5555.6 5585.2 5600.6 4932.0 6033.7 6109.0 6123.6 6153.2 6184.2 6195.2 6212.2 6216.8 6229.6 5756.8 5775.4 5775.8 5782.7 5818.4 6062.5 6166.6 6195.7 6230.0 6230.2 5975.3 6078.4 6107.1 6114.0 6138.8 6182.9 6213.0 6245.5 6289.6 6291.4 5909.8 5965.7 6052.5 6080.1 6128.6 6154.4 6163.9 6190.9 6194.7 6212.8 4967.7 4973.2 4974.8 4981.3 4983.0 4323.4 4348.8 4376.5 4382.4 4498.0 5525.5 5585.3 5619.6 5626.6 5649.9 5179.8 6152.4 6220.9 6248.8 6264.6 4557.8 5357.8 5418.2 5545.3 5606.1 5342.9 5375.8 5378.6 5423.4 5440.7 6233.8 6250.8 6251.2 6271.1 6272.1 5947.6 6115.8 6134.4 6150.4 6160.2 6062.7 6116.4 6149.3 6164.4 6231.3 6076.0 6121.4 6133.8 6135.3 6144.4 6136.8 6139.9 6163.6 6204.6 6220.0 5782.3 5826.7 5928.9 5977.0 6035.9 6041.1 6042.7 6055.1 6062.9 6071.4 5300.5 5667.3 5701.8 5865.0 5894.3 6039.1 6049.3 6098.5 6137.3 6142.5 5894.7 5905.7 5931.3 5939.8 5942.7 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | [#1] ext.html Cycles:180 Average:62709.37 Median:36576.13 stddev:132430.53 (362.1%) stddev-sans-first:132719.50 14:22:22 INFO - PROCESS | 2046 | Values: 439.8 454.8 460.8 488.4 493.4 37853.9 38757.0 38777.6 38805.2 39080.8 39835.4 40224.8 40485.0 40705.4 40863.4 8998.7 9124.5 10578.8 10904.9 10959.3 10788.8 10866.5 10886.1 10889.7 10912.3 10703.8 10842.5 10847.5 10869.4 10880.4 10808.1 10852.7 10888.5 10891.6 10920.5 9004.9 10781.1 10793.9 10800.1 10829.2 36248.3 36550.0 36602.3 36611.5 36684.0 3718.1 3732.2 3735.1 3736.6 3748.3 26919.3 27270.0 27513.7 27676.3 28305.7 2629.5 3072.6 3100.6 3109.7 3225.1 338505.0 385202.2 434111.0 437798.0 442131.0 45698.5 46872.8 51033.7 52719.0 54122.7 57401.4 57575.4 57991.4 58002.4 58009.0 13538.7 13751.2 13773.9 13927.9 13937.0 10391.8 10435.7 10444.6 10469.4 10520.2 13892.9 17512.0 17516.7 17545.3 17567.0 7100.0 7921.2 7925.4 7931.0 7971.4 774.0 847.2 863.6 881.3 884.3 28632.1 29232.4 29311.6 30370.5 30443.7 1027.4 1030.7 1041.8 1075.2 1125.5 15427.8 15456.9 15530.4 15805.4 15837.4 578362.0 580331.0 580660.0 581152.1 582337.0 57067.0 57168.7 57832.7 57996.7 58057.4 1357.7 1391.7 1402.4 1402.6 1414.5 24793.0 25127.6 28101.3 29008.9 29769.0 48841.8 49026.0 49268.0 49458.8 49463.8 480712.0 482959.0 487100.0 489255.0 489439.0 25089.4 26067.3 26068.0 26082.5 26135.9 44547.6 44767.9 45967.0 46236.0 46393.1 37324.4 37397.4 37774.4 38603.6 38778.4 36721.6 36913.4 37097.1 38221.0 38308.4 35956.9 36822.4 36948.0 36979.3 37165.4 30845.5 33304.2 33414.7 33440.5 33494.8 21978.5 23970.9 24285.0 24688.0 25256.5 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | [#2] jquery.html Cycles:180 Average:34384.26 Median:21435.02 stddev:95843.31 (447.1%) stddev-sans-first:96078.18 14:22:22 INFO - PROCESS | 2046 | Values: 386.1 387.2 397.5 401.8 420.5 19401.8 19632.6 20430.6 20771.4 20791.3 12113.8 12284.8 12511.2 16869.2 20774.0 4503.1 4729.5 4818.5 5266.8 5806.4 5966.6 5970.6 6118.7 6149.8 6153.8 5918.3 6004.5 6122.5 6131.0 6160.1 6093.9 6106.7 6131.7 6131.8 6145.3 5807.8 5944.9 6016.7 6022.0 6024.2 13692.0 13880.7 16201.3 25746.0 26376.6 2545.3 2594.4 2633.1 2633.2 2633.3 10061.1 10091.4 10140.3 10530.7 10587.7 1779.2 1799.7 1852.4 1858.1 1865.4 121678.0 132128.0 132208.7 133382.0 135650.0 12002.9 12179.0 12242.2 12311.0 12537.2 16069.7 16181.6 16192.8 16202.2 16202.9 8275.4 8466.3 8479.3 8499.6 8594.9 7904.1 8040.2 8145.0 8147.1 8157.2 4846.7 4932.4 4933.2 4938.1 5032.7 2045.5 2086.2 2094.6 2101.2 2104.3 815.6 901.8 943.0 1027.7 1059.5 20202.7 21266.6 21603.5 21719.7 21814.9 1031.8 1037.9 1064.1 1070.1 1072.6 10725.4 11291.4 11422.0 11474.7 11475.8 335084.0 405367.0 658021.0 666173.0 666680.0 101919.0 135618.0 138963.3 160623.0 163260.0 972.3 978.9 994.0 998.9 1000.9 15672.8 15693.1 15780.2 18267.1 19949.3 47665.5 57006.4 61325.0 61884.0 62601.7 71544.6 89744.0 90405.1 91015.6 91241.1 6607.4 8116.4 8133.6 8587.7 8608.1 12183.7 12477.3 12914.0 13216.9 13236.0 10951.4 11228.0 11303.8 11355.9 11356.8 10612.7 10867.7 10988.9 11330.7 11343.7 10445.5 10493.4 10942.5 11255.6 11418.7 6941.8 7575.7 7598.3 7751.2 8691.9 9060.5 9421.5 11439.9 11455.3 11470.5 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | [#3] mootools.html Cycles:180 Average:5471.95 Median:5140.18 stddev:3041.59 (59.2%) stddev-sans-first:3033.65 14:22:22 INFO - PROCESS | 2046 | Values: 1260.0 1302.6 1381.5 1438.7 1456.6 7761.9 7955.7 8257.5 8625.8 8709.3 8345.4 8573.4 8575.6 8580.4 8589.2 1781.1 1893.4 1905.4 2243.3 2285.6 2121.8 2265.8 2305.4 2310.0 2316.3 2020.8 2152.7 2269.4 2288.5 2294.6 2252.5 2275.2 2275.3 2276.1 2279.2 1838.5 1966.0 2031.2 2306.3 2316.9 8157.1 8474.2 8474.7 8489.6 8558.1 5060.7 5152.7 5216.9 5218.2 5224.2 3371.3 3457.0 3463.5 3517.6 3551.6 1214.2 1216.2 1238.9 1261.8 1266.8 9189.4 10747.2 10909.7 11060.0 11060.7 4462.8 4676.3 4723.2 4735.8 4754.7 9584.5 9662.2 9679.9 9683.8 9700.4 5188.5 5241.8 5273.5 5280.5 5280.7 4578.4 4730.0 4786.1 4802.7 4802.7 3771.6 3823.9 3872.6 3909.8 3918.5 1254.8 1275.1 1276.3 1283.9 1284.0 729.2 870.4 877.0 888.0 888.8 5120.2 5396.3 5525.4 5537.2 5598.6 577.1 584.1 595.4 595.6 601.6 3621.8 3783.6 3789.4 4040.2 4041.8 10019.2 10199.5 10237.9 10244.4 10251.4 10011.2 10062.8 10167.5 10180.1 10188.2 7764.5 7785.1 7985.6 8004.4 8024.4 4739.4 5592.4 5715.2 5801.1 5894.0 8900.2 9053.2 9321.6 9483.0 9506.7 9220.5 9390.7 9394.4 9489.8 9529.6 7111.8 7228.2 7324.5 7348.8 7354.9 7984.6 8079.0 8099.9 8127.3 8131.9 7290.3 7359.2 7370.4 7415.3 7494.1 7202.6 7204.8 7210.5 7213.6 7318.3 6369.6 6376.8 6408.9 6445.6 6456.1 4958.8 5009.6 5023.1 5044.9 5080.1 4898.3 4911.1 5061.9 5138.2 5142.1 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | [#4] prototype.html Cycles:180 Average:4607.26 Median:5062.65 stddev:1392.01 (27.5%) stddev-sans-first:1358.21 14:22:22 INFO - PROCESS | 2046 | Values: 320.3 336.9 339.8 372.9 373.4 5124.4 5530.5 5553.8 5562.9 5582.4 4030.1 4601.8 4764.4 5417.5 5474.1 3180.0 3846.9 4020.7 4104.9 4149.9 3455.8 3465.4 3902.7 4136.6 4143.0 3535.4 3597.6 3848.4 4122.3 4130.4 3245.4 4100.5 4131.4 4144.3 4188.4 3333.7 3733.3 3739.6 3751.3 3753.4 4400.5 4747.9 5288.6 5333.2 5359.2 4729.8 4929.0 4975.2 4999.9 5009.4 5110.5 5704.7 5752.2 5777.4 5779.7 3877.2 4221.0 4224.6 4237.6 4254.6 5249.2 5279.8 5510.8 5658.5 5947.5 4082.4 4205.2 4239.3 4252.6 4263.0 4320.1 4321.8 4327.9 4338.1 4341.2 4372.8 4465.7 4674.9 4954.2 4983.9 5245.8 5531.9 5783.2 5786.4 5815.4 1279.6 1330.8 1407.2 1420.6 1439.7 929.2 941.4 1006.5 1007.9 1014.8 4430.1 4842.3 5081.8 5182.3 5210.4 4836.9 5002.1 5194.5 5333.6 5813.8 3896.9 4460.1 4942.6 5090.6 5092.5 2966.0 3013.4 3014.8 3022.5 3030.6 5067.7 5308.8 5582.1 5775.3 5923.2 5621.4 5789.5 5857.2 6059.5 6091.6 5957.5 6011.8 6165.9 6171.2 6173.4 5057.6 5515.6 5516.9 5595.8 6010.2 4843.6 4925.6 5407.0 5834.2 5948.7 4909.7 5431.6 6122.3 6212.8 6222.3 3358.8 3916.1 3985.8 3988.3 4014.5 4630.9 5628.3 5826.5 5895.8 5919.4 4565.9 5076.8 5731.6 5794.8 5830.8 5330.0 5589.8 5655.5 5814.2 5825.5 5137.1 5512.5 5578.5 5642.3 5694.8 5779.0 5806.2 5820.0 5820.3 5825.5 5459.8 5610.8 5687.0 5692.0 5706.5 14:22:22 INFO - PROCESS | 2046 | 14:22:22 INFO - PROCESS | 2046 | [#5] yui.html Cycles:180 Average:19423.56 Median:4060.34 stddev:26964.58 (664.1%) stddev-sans-first:27003.25 14:22:22 INFO - PROCESS | 2046 | Values: 618.8 699.0 723.3 785.7 822.9 13797.4 14555.8 14641.7 15136.3 15504.5 13825.6 14063.2 14107.7 14307.5 14326.5 870.5 887.7 890.1 892.9 894.2 872.1 884.8 886.9 902.9 910.8 944.2 949.4 949.9 952.8 953.7 913.4 936.4 947.6 949.4 949.8 683.9 700.8 703.7 705.5 705.5 14574.9 15109.4 15304.0 15327.5 15360.7 14185.9 14341.1 14393.4 14446.8 14465.1 10498.5 11589.1 11670.7 11787.2 12310.0 3648.6 3699.4 3703.9 3720.0 3848.9 96947.0 97077.0 97864.5 98254.5 98269.5 10862.9 10982.0 11117.3 11202.2 11550.0 22684.0 22796.0 22851.0 23058.2 23129.4 7656.5 7680.9 7700.8 7751.8 7829.6 3656.0 4024.8 4174.0 4212.7 4274.6 3590.8 3658.5 3682.8 3685.9 3697.1 596.2 661.5 674.2 676.8 690.7 673.3 702.7 704.7 710.4 717.4 9790.1 9878.3 10500.0 10561.9 10636.4 643.4 700.6 707.4 717.4 725.7 4095.9 4188.6 4705.5 4978.3 5017.5 77019.1 97045.0 100905.0 102092.0 102301.5 74702.0 77967.6 80256.6 84839.6 92034.0 54764.7 67158.7 73175.0 75973.0 76935.0 8928.7 9294.3 10589.5 10606.6 10843.6 40986.2 42006.8 49279.0 50229.0 50906.0 60132.0 60698.0 60889.4 61566.4 63031.0 12557.5 12825.9 12900.9 13143.4 13309.9 14427.9 14470.9 14786.5 14828.6 15401.2 13415.6 13522.3 13670.2 14068.8 14514.3 13547.0 13670.1 13814.5 13817.5 14312.6 13365.9 13447.7 13451.0 13874.2 13924.4 10364.6 10842.0 11170.6 11266.7 11466.3 10247.8 10986.2 11103.6 11115.5 11136.5 14:22:22 INFO - PROCESS | 2046 | -------- Summary: end -------- 14:22:22 INFO - PROCESS | 2046 | 14:22:23 INFO - TEST-INFO | 2046: exit 0 14:22:23 INFO - TEST-OK | dromaeo_css | took 1115709ms 14:22:23 INFO - TEST-START | kraken 14:22:23 INFO - operating with platform_type : mac_ 14:22:23 INFO - Initialising browser for kraken test... 14:22:23 INFO - TEST-INFO | started process 2052 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpGne7yK/profile http://localhost:49299/getInfo.html) 14:22:25 INFO - PROCESS | 2052 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 14:22:25 INFO - PROCESS | 2052 | 2017-02-05 14:22:25.962 plugin-container[2053:23774] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 14:22:25 INFO - PROCESS | 2052 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:25 INFO - PROCESS | 2052 | 2017-02-05 14:22:25.965 plugin-container[2053:23774] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4423, name = 'com.apple.CFPasteboardClient' 14:22:25 INFO - PROCESS | 2052 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:25 INFO - PROCESS | 2052 | 2017-02-05 14:22:25.966 plugin-container[2053:23774] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:22:26 INFO - PROCESS | 2052 | __metrics Screen width/height:1600/1200 14:22:26 INFO - PROCESS | 2052 | colorDepth:24 14:22:26 INFO - PROCESS | 2052 | Browser inner width/height: 1024/689 14:22:26 INFO - PROCESS | 2052 | __metrics 14:22:26 ERROR - PROCESS | 2052 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 14:22:26 INFO - PROCESS | 2052 | 1486333346126 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpGne7yK/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpGne7yK/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpGne7yK/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpGne7yK/profile/extensions/talos-powers@TalosPowersService.js:55:9 14:22:26 INFO - TEST-INFO | 2052: exit 0 14:22:26 INFO - Browser initialized. 14:22:26 INFO - Running cycle 1/1 for kraken test... 14:22:26 INFO - TEST-INFO | started process 2054 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpGne7yK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:29 INFO - PROCESS | 2054 | 2017-02-05 14:22:29.398 plugin-container[2055:23888] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863b, name = 'com.apple.tsm.portname' 14:22:29 INFO - PROCESS | 2054 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:29 INFO - PROCESS | 2054 | 2017-02-05 14:22:29.399 plugin-container[2055:23888] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 14:22:29 INFO - PROCESS | 2054 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:29 INFO - PROCESS | 2054 | 2017-02-05 14:22:29.399 plugin-container[2055:23888] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:22:38 INFO - PROCESS | 2054 | RSS: Main: 232169472 14:22:38 INFO - PROCESS | 2054 | 14:22:42 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:43 INFO - PROCESS | 2054 | RSS: Main: 247033856 14:22:43 INFO - PROCESS | 2054 | 14:22:45 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-dft) 14:22:46 INFO - PROCESS | 2054 | RSS: Main: 254808064 14:22:46 INFO - PROCESS | 2054 | 14:22:49 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-fft) 14:22:50 INFO - PROCESS | 2054 | RSS: Main: 257495040 14:22:50 INFO - PROCESS | 2054 | 14:22:52 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-oscillator) 14:22:52 INFO - PROCESS | 2054 | RSS: Main: 259702784 14:22:52 INFO - PROCESS | 2054 | 14:22:54 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:55 INFO - PROCESS | 2054 | RSS: Main: 260587520 14:22:55 INFO - PROCESS | 2054 | 14:22:58 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:59 INFO - PROCESS | 2054 | RSS: Main: 266358784 14:22:59 INFO - PROCESS | 2054 | 14:23:02 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-desaturate) 14:23:03 INFO - PROCESS | 2054 | RSS: Main: 265519104 14:23:03 INFO - PROCESS | 2054 | 14:23:06 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49299/tests/kraken/driver.html?testName=json-parse-financial) 14:23:07 INFO - PROCESS | 2054 | RSS: Main: 265273344 14:23:07 INFO - PROCESS | 2054 | 14:23:08 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:23:09 INFO - PROCESS | 2054 | RSS: Main: 264998912 14:23:09 INFO - PROCESS | 2054 | 14:23:11 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:11 INFO - PROCESS | 2054 | RSS: Main: 264990720 14:23:11 INFO - PROCESS | 2054 | 14:23:14 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:14 INFO - PROCESS | 2054 | RSS: Main: 265138176 14:23:14 INFO - PROCESS | 2054 | 14:23:17 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:18 INFO - PROCESS | 2054 | RSS: Main: 265490432 14:23:18 INFO - PROCESS | 2054 | 14:23:21 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:22 INFO - PROCESS | 2054 | RSS: Main: 265297920 14:23:22 INFO - PROCESS | 2054 | 14:23:23 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49299/tests/kraken/driver.html?testName=ai-astar) 14:23:24 INFO - PROCESS | 2054 | RSS: Main: 267268096 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | __start_tp_report 14:23:24 INFO - PROCESS | 2054 | _x_x_mozilla_page_load 14:23:24 INFO - PROCESS | 2054 | _x_x_mozilla_page_load_details 14:23:24 INFO - PROCESS | 2054 | |i|pagename|runs| 14:23:24 INFO - PROCESS | 2054 | |0;ai-astar;106;119;118;117;139;173;151;115;116;118 14:23:24 INFO - PROCESS | 2054 | |1;audio-beat-detection;143;143;99;186;144;141;109;115;130;115 14:23:24 INFO - PROCESS | 2054 | |2;audio-dft;210;215;277;263;199;201;195;202;194;197 14:23:24 INFO - PROCESS | 2054 | |3;audio-fft;80;59;59;87;59;62;59;58;72;61 14:23:24 INFO - PROCESS | 2054 | |4;audio-oscillator;87;73;84;72;70;72;86;101;107;114 14:23:24 INFO - PROCESS | 2054 | |5;imaging-gaussian-blur;92;90;91;89;122;85;137;130;106;89 14:23:24 INFO - PROCESS | 2054 | |6;imaging-darkroom;97;152;89;97;90;133;153;124;98;96 14:23:24 INFO - PROCESS | 2054 | |7;imaging-desaturate;93;107;94;96;107;112;146;148;101;145 14:23:24 INFO - PROCESS | 2054 | |8;json-parse-financial;65;64;64;66;66;65;64;66;64;63 14:23:24 INFO - PROCESS | 2054 | |9;json-stringify-tinderbox;68;76;73;80;75;71;71;71;75;67 14:23:24 INFO - PROCESS | 2054 | |10;stanford-crypto-aes;87;86;88;90;89;89;88;89;91;87 14:23:24 INFO - PROCESS | 2054 | |11;stanford-crypto-ccm;147;165;156;157;136;138;148;136;202;189 14:23:24 INFO - PROCESS | 2054 | |12;stanford-crypto-pbkdf2;206;176;173;174;176;176;174;171;170;170 14:23:24 INFO - PROCESS | 2054 | |13;stanford-crypto-sha256-iterative;69;68;68;65;69;67;67;69;67;68 14:23:24 INFO - PROCESS | 2054 | __end_tp_report 14:23:24 INFO - PROCESS | 2054 | __start_cc_report 14:23:24 INFO - PROCESS | 2054 | _x_x_mozilla_cycle_collect,1015 14:23:24 INFO - PROCESS | 2054 | __end_cc_report 14:23:24 INFO - PROCESS | 2054 | __startTimestamp1486333404069__endTimestamp 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | ------- Summary: start ------- 14:23:24 INFO - PROCESS | 2054 | Number of tests: 14 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#0] ai-astar Cycles:10 Average:127.20 Median:118.50 stddev:20.73 (17.5%) stddev-sans-first:20.52 14:23:24 INFO - PROCESS | 2054 | Values: 106.0 119.0 118.0 117.0 139.0 173.0 151.0 115.0 116.0 118.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:143.00 stddev:24.90 (17.4%) stddev-sans-first:26.12 14:23:24 INFO - PROCESS | 2054 | Values: 143.0 143.0 99.0 186.0 144.0 141.0 109.0 115.0 130.0 115.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#2] audio-dft Cycles:10 Average:215.30 Median:206.00 stddev:29.74 (14.4%) stddev-sans-first:31.48 14:23:24 INFO - PROCESS | 2054 | Values: 210.0 215.0 277.0 263.0 199.0 201.0 195.0 202.0 194.0 197.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#3] audio-fft Cycles:10 Average:65.60 Median:61.50 stddev:10.39 (16.9%) stddev-sans-first:9.63 14:23:24 INFO - PROCESS | 2054 | Values: 80.0 59.0 59.0 87.0 59.0 62.0 59.0 58.0 72.0 61.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:72.50 stddev:15.88 (21.9%) stddev-sans-first:16.84 14:23:24 INFO - PROCESS | 2054 | Values: 87.0 73.0 84.0 72.0 70.0 72.0 86.0 101.0 107.0 114.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:89.00 stddev:19.45 (21.9%) stddev-sans-first:20.21 14:23:24 INFO - PROCESS | 2054 | Values: 92.0 90.0 91.0 89.0 122.0 85.0 137.0 130.0 106.0 89.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#6] imaging-darkroom Cycles:10 Average:112.90 Median:93.00 stddev:25.33 (27.2%) stddev-sans-first:26.20 14:23:24 INFO - PROCESS | 2054 | Values: 97.0 152.0 89.0 97.0 90.0 133.0 153.0 124.0 98.0 96.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#7] imaging-desaturate Cycles:10 Average:114.90 Median:147.00 stddev:22.53 (15.3%) stddev-sans-first:22.46 14:23:24 INFO - PROCESS | 2054 | Values: 93.0 107.0 94.0 96.0 107.0 112.0 146.0 148.0 101.0 145.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 14:23:24 INFO - PROCESS | 2054 | Values: 65.0 64.0 64.0 66.0 66.0 65.0 64.0 66.0 64.0 63.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:74.00 stddev:3.92 (5.3%) stddev-sans-first:3.77 14:23:24 INFO - PROCESS | 2054 | Values: 68.0 76.0 73.0 80.0 75.0 71.0 71.0 71.0 75.0 67.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:1.51 (1.7%) stddev-sans-first:1.51 14:23:24 INFO - PROCESS | 2054 | Values: 87.0 86.0 88.0 90.0 89.0 89.0 88.0 89.0 91.0 87.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#11] stanford-crypto-ccm Cycles:10 Average:157.40 Median:156.50 stddev:22.45 (14.3%) stddev-sans-first:23.50 14:23:24 INFO - PROCESS | 2054 | Values: 147.0 165.0 156.0 157.0 136.0 138.0 148.0 136.0 202.0 189.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:175.00 stddev:10.60 (6.1%) stddev-sans-first:2.50 14:23:24 INFO - PROCESS | 2054 | Values: 206.0 176.0 173.0 174.0 176.0 176.0 174.0 171.0 170.0 170.0 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - PROCESS | 2054 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.24 14:23:24 INFO - PROCESS | 2054 | Values: 69.0 68.0 68.0 65.0 69.0 67.0 67.0 69.0 67.0 68.0 14:23:24 INFO - PROCESS | 2054 | -------- Summary: end -------- 14:23:24 INFO - PROCESS | 2054 | 14:23:24 INFO - TEST-INFO | 2054: exit 0 14:23:24 INFO - TEST-OK | kraken | took 61791ms 14:23:24 INFO - SUITE-END | took 1177s 14:23:25 INFO - Completed test suite (00:19:37) 14:23:25 INFO - javascript benchmark 14:23:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7213.663310587031, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.785318954268, 3332.5334453176542, 3336.666333366662, 3354.5135955286482, 3355.7986520808754, 5418.349798024243, 5487.286652735143, 5509.035918714229, 5541.002619528488, 5566.777328906849, 5436.809711660093, 5523.696196709179, 5566.248556444879, 5598.972005139979, 5647.124695672167, 4980.900381992358, 5053.6715113517685, 5123.846284611468, 5133.435322114565, 5169.508896654812, 4949.752512374385, 5116.0, 5172.120739474299, 5193.195054766517, 5203.739813009353, 3748.512693349861, 4922.212446008657, 4970.502949705036, 5088.109580823379, 5129.820456284012, 5022.6233032522705, 5034.672746271481, 5096.133657278272, 5133.6149788765615, 5138.845834624967, 4976.676516026447, 5038.345015148007, 5075.187969924795, 5079.746012699387, 5138.614603904722, 5405.945940540583, 5429.212764149216, 5555.611107222496, 5585.162225666142, 5600.6079574429805, 4932.0, 6033.668148251844, 6109.040306147832, 6123.557162997608, 6153.169322141498, 6184.19605451293, 6195.163652906845, 6212.192414986023, 6216.7824126155365, 6229.626222426669, 5756.769729210869, 5775.364709881952, 5775.768969241268, 5782.681952492611, 5818.41815818419, 6062.454379105901, 6166.568340216231, 6195.690215489208, 6229.96885015572, 6230.158928544589, 5975.312839023481, 6078.361772013964, 6107.097787096137, 6114.023656277693, 6138.817583427401, 6182.907256391158, 6212.968935155295, 6245.469135123474, 6289.591176573508, 6291.370862913672, 5909.8227053188475, 5965.701714914237, 6052.546059045501, 6080.0575910733905, 6128.571000030044, 6154.415330543591, 6163.876722465526, 6190.938090619036, 6194.690265486708, 6212.844678883064, 4967.726775027336, 4973.179425394842, 4974.801007959713, 4981.327520784647, 4982.950170498321, 4323.416338794285, 4348.760818154969, 4376.518582955872, 4382.386465894777, 4498.0, 5525.475079867406, 5585.3297604287745, 5619.578531610146, 5626.578006649518, 5649.915251271234, 5179.766910489037, 6152.446279834837, 6220.875582488325, 6248.843778905472, 6264.614769661255, 4557.794899229542, 5357.812476563302, 5418.241446197536, 5545.251391062155, 5606.103023516218, 5342.9465705342445, 5375.75809088592, 5378.596605254622, 5423.376311724123, 5440.700761458079, 6233.75064997395, 6250.843728906813, 6251.156093927261, 6271.090691849565, 6272.059191121369, 5947.613405128653, 6115.816525504242, 6134.35589263121, 6150.415710507495, 6160.199174107516, 6062.727177277121, 6116.39664026098, 6149.323574406722, 6164.352742961924, 6231.345708700521, 6076.0, 6121.390971446752, 6133.76314253068, 6135.325114237341, 6144.402455361727, 6136.825445958321, 6139.907901381573, 6163.630182189083, 6204.5967012144065, 6220.0, 5782.335031471434, 5826.7086645666695, 5928.911066334094, 5977.043673012297, 6035.909461358171, 6041.063635136561, 6042.697865106639, 6055.091736239599, 6062.878742425215, 6071.392860713893, 5300.469953004668, 5667.291588551431, 5701.800436984851, 5864.970675146597, 5894.263217097863, 6039.094135879654, 6049.304330002106, 6098.451139397475, 6137.3248942617165, 6142.539309551712, 5894.70526473666, 5905.734241959036, 5931.258592675916, 5939.762409503572, 5942.702864856827], "value": 5587.164686580739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.8174757475648, 454.84080571799853, 460.82718980382356, 488.3943909552156, 493.36109737889427, 37853.86438406849, 38757.0, 38777.61222387775, 38805.223895522075, 39080.80459597702, 39835.40246896299, 40224.798876005654, 40485.0, 40705.38941915874, 40863.38704919429, 8998.730038098867, 9124.543772811367, 10578.841317380207, 10904.890951090467, 10959.287646303004, 10788.838167427495, 10866.511007004703, 10886.0746836519, 10889.727756806104, 10912.345259284468, 10703.83944240833, 10842.457877106153, 10847.457627118652, 10869.402182879938, 10880.401577913211, 10808.081313088396, 10852.728681782939, 10888.455577221146, 10891.564337426493, 10920.453977301182, 9004.909950900472, 10781.137508999262, 10793.892061079367, 10800.081993030602, 10829.241953063289, 36248.27503449943, 36550.0, 36602.26795464102, 36611.4508282376, 36684.0, 3718.1076541629814, 3732.234891847165, 3735.14091758897, 3736.6263373662687, 3748.250349930025, 26919.26511382359, 27270.04554840571, 27513.724862751318, 27676.30809229765, 28305.716942830513, 2629.53983052965, 3072.554479600468, 3100.5969224000737, 3109.70457806508, 3225.080851957181, 338505.0, 385202.2219666679, 434111.0, 437798.0, 442131.0, 45698.543014569426, 46872.7656361716, 51033.74483127561, 52719.0, 54122.7293863536, 57401.42598573961, 57575.424245757844, 57991.420085799444, 58002.41997580055, 58009.0, 13538.661533461742, 13751.174929504261, 13773.862261377459, 13927.860721392859, 13937.024408291321, 10391.84412233817, 10435.68692939213, 10444.582216711246, 10469.424181670081, 10520.158387328995, 13892.93053534726, 17512.0, 17516.737248941277, 17545.29818807259, 17567.0, 7100.0, 7921.247481489249, 7925.365970722443, 7931.0, 7971.40214483916, 773.9922600774033, 847.2332539052168, 863.5690531154779, 881.3478026260522, 884.3323290915317, 28632.14103576896, 29232.415351692845, 29311.560326595118, 30370.54444183339, 30443.695563044086, 1027.4143738069379, 1030.7114008077601, 1041.8280983637615, 1075.2043487818958, 1125.5441546173813, 15427.768583471257, 15456.92271538635, 15530.378784848706, 15805.446809361847, 15837.445689401045, 578362.0, 580331.0, 580660.0, 581152.0942395261, 582337.0, 57067.0, 57168.71415642895, 57832.71083644555, 57996.710016449644, 58057.419425806045, 1357.7148798752175, 1391.7216556688702, 1402.3759427054863, 1402.5792262321263, 1414.5473448496589, 24793.00827966861, 25127.623085653366, 28101.297467563476, 29008.854955725088, 29769.0, 48841.755791220814, 49026.0, 49268.0, 49458.752706236235, 49463.752681236365, 480712.0, 482959.0, 487100.0, 489255.0, 489439.0, 25089.372765681004, 26067.348316291485, 26067.95728170852, 26082.478350433266, 26135.869320653273, 44547.554524455634, 44767.88080298019, 45967.0, 46236.0, 46393.07213855771, 37324.440133398566, 37397.439038413904, 37774.43338349982, 38603.61396386113, 38778.4183237246, 36721.63278367289, 36913.41606087548, 37097.072573185884, 38221.044473888374, 38308.425373619975, 35956.92129236127, 36822.44766328561, 36948.0, 36979.260414792094, 37165.442518361706, 30845.537316939815, 33304.1673958153, 33414.665853341154, 33440.498392523645, 33494.81314835646, 21978.45053873602, 23970.88014559916, 24285.028598855846, 24688.0, 25256.494870102862], "value": 19190.63971462875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.08497860071634, 387.1946351588696, 397.46739369245205, 401.77299825598544, 420.50800563340886, 19401.805981940193, 19632.607347853034, 20430.591388172266, 20771.376858694246, 20791.272305469312, 12113.757724845498, 12284.815727764068, 12511.249325040504, 16869.240884160212, 20774.0, 4503.144402563519, 4729.4797572267025, 4818.542238487338, 5266.7893284268675, 5806.448387403211, 5966.612170208944, 5970.641761494303, 6118.663473508956, 6149.815505534819, 6153.846153846167, 5918.2898052233795, 6004.519638428916, 6122.510199184077, 6130.969345153268, 6160.106784516242, 6093.908591371133, 6106.694665266741, 6131.724072416752, 6131.816045518642, 6145.293291271494, 5807.82576522705, 5944.940550594482, 6016.69916504173, 6022.006368949118, 6024.21685180928, 13692.0, 13880.652983675387, 16201.270942807601, 25746.0, 26376.604350934558, 2545.2618740565213, 2594.3514121469634, 2633.1310667479684, 2633.2231991562535, 2633.302174923647, 10061.094501494827, 10091.394516329045, 10140.290179687425, 10530.684079477627, 10587.682369528926, 1779.1904683369166, 1799.658064967665, 1852.4164888060352, 1858.1173942377397, 1865.4310435317223, 121678.0, 132128.0, 132208.6779132206, 133382.0, 135650.0, 12002.879971200351, 12179.0, 12242.204256723284, 12311.0, 12537.247765134121, 16069.67860642804, 16181.59546011359, 16192.75710864338, 16202.189890505428, 16202.918985404998, 8275.420720549624, 8466.280366168945, 8479.279261262738, 8499.61751721174, 8594.914050859412, 7904.0910295315625, 8040.195980401913, 8145.0, 8147.144549822302, 8157.2250636189465, 4846.684965477303, 4932.4327702314695, 4933.235348520985, 4938.135826230396, 5032.72320022395, 2045.5170001748613, 2086.1968142265337, 2094.628018647788, 2101.2120454829437, 2104.316097268363, 815.571824791989, 901.833160865242, 943.0239701908491, 1027.6762819711766, 1059.5179193466954, 20202.696959545618, 21266.57466850685, 21603.459913501974, 21719.67420488694, 21814.890925545587, 1031.8039572481205, 1037.9377237365782, 1064.084886997182, 1070.1011150633506, 1072.5656109275756, 10725.356478611307, 11291.378974156336, 11422.0, 11474.655760327036, 11475.8278625819, 335084.0, 405367.0, 658021.0, 666173.0, 666680.0, 101919.0, 135618.0, 138963.30518347342, 160623.0, 163260.0, 972.2902281334665, 978.8776402949632, 993.9950300248453, 998.9051040151174, 1000.8798944126752, 15672.754009101332, 15693.136877471848, 15780.210989450712, 18267.08664566793, 19949.301774437827, 47665.52334476611, 57006.429935700115, 61325.0, 61884.0, 62601.74796504135, 71544.64227678828, 89744.0, 90405.09594903966, 91015.63476547989, 91241.08758912326, 6607.438367738796, 8116.391270654606, 8133.552654604054, 8587.65649374018, 8608.139186081342, 12183.695407614881, 12477.251364918135, 12914.0, 13216.933915330363, 13236.007299452773, 10951.397673127736, 11227.989480946753, 11303.830442543533, 11355.943220283845, 11356.772864542829, 10612.734681633021, 10867.728306792393, 10988.890111098786, 11330.716732081764, 11343.659690209306, 10445.477726113815, 10493.422861742372, 10942.507587158438, 11255.606053788078, 11418.714532136763, 6941.791746247621, 7575.6969721210535, 7598.278163574451, 7751.186125456746, 8691.913080869363, 9060.501672408082, 9421.528923553931, 11439.942800286279, 11455.312681239153, 11470.541178352772], "value": 9621.624257286767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.9748005039899, 1302.6157283601337, 1381.52337443582, 1438.7410266152092, 1456.5775924981756, 7761.922380776191, 7955.681772729084, 8257.463264887778, 8625.784355391119, 8709.303255739542, 8345.415820892526, 8573.356998225143, 8575.571221438919, 8580.356473264499, 8589.226969572737, 1781.1450503758203, 1893.3751861885544, 1905.3712274949235, 2243.349428665685, 2285.5771682238837, 2121.819645330149, 2265.796078352948, 2305.400595845084, 2310.0297874892585, 2316.339843144696, 2020.7676117246485, 2152.719132116396, 2269.4212975691175, 2288.496530763229, 2294.609916314222, 2252.5044490212126, 2275.2150508074687, 2275.2719129878446, 2276.146445083077, 2279.213671283413, 1838.4760343302094, 1965.9508512287307, 2031.2281333093479, 2306.261996161229, 2316.860988340705, 8157.143499932481, 8474.237318641352, 8474.703385381483, 8489.575521223976, 8558.058613552505, 5060.671056381323, 5152.716600586966, 5216.8695782605355, 5218.191180367049, 5224.164133738584, 3371.342588195303, 3456.997470733484, 3463.497792820027, 3517.6130625631417, 3551.6448355164275, 1214.2107630040457, 1216.1669256559285, 1238.851337839456, 1261.7728808814409, 1266.803645434959, 9189.44863308197, 10747.247692661516, 10909.672709818718, 11060.004599586076, 11060.723481912935, 4462.799174037176, 4676.275177347517, 4723.220668589644, 4735.786889589976, 4754.667173297905, 9584.520773961274, 9662.178714809179, 9679.93520712721, 9683.806323873483, 9700.417974921527, 5188.45521220274, 5241.816536421207, 5273.499017593323, 5280.498352656491, 5280.735963201824, 4578.35902973584, 4729.95270047302, 4786.138495070921, 4802.663813533089, 4802.679263202577, 3771.6427232979386, 3823.866164684223, 3872.5546562145714, 3909.7849618270698, 3918.549366822852, 1254.7553227120807, 1275.0883118570266, 1276.2916581297468, 1283.8972882169403, 1283.9550615728406, 729.2160927003492, 870.3646338173169, 876.9693060742843, 888.0320450708758, 888.7733627924838, 5120.18077107661, 5396.2984811974975, 5525.4474552544425, 5537.169424586264, 5598.552115830724, 577.1371799160282, 584.1354794903482, 595.3659352789266, 595.553334998751, 601.6239850093691, 3621.7826930383735, 3783.564890037626, 3789.3558095123894, 4040.1919616076902, 4041.81811818463, 10019.248556358303, 10199.54102065409, 10237.9488102559, 10244.436555989492, 10251.38491690501, 10011.249156313306, 10062.798744025078, 10167.542460589291, 10180.134688551409, 10188.184945204366, 7764.456488045896, 7785.104712958082, 7985.640646170937, 8004.439689221815, 8024.398170137147, 4739.4075740532435, 5592.440755924375, 5715.228444160151, 5801.100829371454, 5893.970530147321, 8900.154485323885, 9053.185213330831, 9321.627134914528, 9482.95258523703, 9506.667266645634, 9220.492872892055, 9390.67132650354, 9394.436333819993, 9489.762755931157, 9529.61881524759, 7111.7866464006165, 7228.241034691492, 7324.450666199949, 7348.77953661391, 7354.926450735424, 7984.640691169027, 8079.0, 8099.947006889067, 8127.268545830903, 8131.878021829795, 7290.270972902879, 7359.190489046307, 7370.44721645868, 7415.3326200642205, 7494.063242094739, 7202.639868006474, 7204.783856484314, 7210.459215558959, 7213.60325182099, 7318.3047610476915, 6369.554131210771, 6376.808695739135, 6408.9038664421005, 6445.581037232565, 6456.096146539394, 4958.801647934187, 5009.574186194214, 5023.09584274834, 5044.924326135184, 5080.11098057831, 4898.2897479864505, 4911.140550403594, 5061.898762024665, 5138.229265610188, 5142.125838607521], "value": 4363.03033017591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.29854618385735, 336.8551522845177, 339.7808413573245, 372.94219395993616, 373.4044199501794, 5124.436312005681, 5530.4746049125315, 5553.805616803413, 5562.944370556298, 5582.358028826686, 4030.1335212929216, 4601.769911504428, 4764.380630518028, 5417.51242388186, 5474.124140137579, 3179.9841000794963, 3846.9230615387673, 4020.6984476164403, 4104.917901641966, 4149.875503734893, 3455.8272086395705, 3465.3935561276676, 3902.69259797968, 4136.627703506684, 4142.958570414303, 3535.4166562517153, 3597.622249663774, 3848.3650197717484, 4122.2992091344395, 4130.421740956269, 3245.3996010738088, 4100.528439229497, 4131.380292956081, 4144.295469770132, 4188.4136220929095, 3333.7166340861054, 3733.2720119576693, 3739.626037396266, 3751.3247615429214, 3753.399456087013, 4400.493943196541, 4747.928781068286, 5288.603354748409, 5333.226682131108, 5359.222912677679, 4729.787159577792, 4928.975355123237, 4975.203967365241, 4999.925001124986, 5009.44896061433, 5110.488951104897, 5704.743286552115, 5752.194692743019, 5777.364489906107, 5779.711014449303, 3877.1664092220026, 4220.978895105505, 4224.598663126998, 4237.555056719062, 4254.553271906436, 5249.2126181073145, 5279.841604751864, 5510.752016159283, 5658.462446067617, 5947.494462970652, 4082.3876418537457, 4205.243056249843, 4239.27932251518, 4252.575387245308, 4263.0, 4320.092780516064, 4321.762303073361, 4327.891802704958, 4338.110687309094, 4341.175176716414, 4372.753765176909, 4465.650761928554, 4674.929876051862, 4954.232094025432, 4983.8504844854715, 5245.790168393298, 5531.8893622128135, 5783.16144159103, 5786.363500014995, 5815.429833944811, 1279.5969269680022, 1330.7538105450328, 1407.190865252484, 1420.6164335629321, 1439.6544829240906, 929.2426672262085, 941.4304345870787, 1006.4514839412537, 1007.8891321954579, 1014.7666036811574, 4430.136123455895, 4842.322074909515, 5081.822136225288, 5182.305201295306, 5210.358736997833, 4836.927446088312, 5002.1496345621335, 5194.454717188551, 5333.573314134937, 5813.767449302065, 3896.9088655176597, 4460.104455606354, 4942.616067501105, 5090.567301779391, 5092.541671249532, 2965.976738025378, 3013.382256637384, 3014.7889647724887, 3022.531507616323, 3030.636323641177, 5067.670601410897, 5308.840734777963, 5582.051051321285, 5775.306963164363, 5923.229980102559, 5621.409751975983, 5789.45000224978, 5857.238558987305, 6059.454649081604, 6091.634501929899, 5957.527626035234, 6011.789587364421, 6165.872773893089, 6171.21034899874, 6173.425776427072, 5057.620678449204, 5515.61390702663, 5516.9448305516435, 5595.804146854841, 6010.158577799024, 4843.612510999182, 4925.556699897026, 5407.0, 5834.15404766315, 5948.672822994777, 4909.656324057281, 5431.565474762088, 6122.2959359674205, 6212.844678882883, 6222.346653601307, 3358.833552358764, 3916.099297161612, 3985.8007099644324, 3988.282109220252, 4014.4781178446615, 4630.930536042029, 5628.324601047901, 5826.504747096375, 5895.764169433346, 5919.437653422918, 4565.908681826411, 5076.847694569169, 5731.598788084794, 5794.82615521535, 5830.7959221427045, 5329.973350133225, 5589.776408943597, 5655.539840169539, 5814.16853691086, 5825.475707186373, 5137.126688463045, 5512.476314750093, 5578.470045345685, 5642.266505354278, 5694.829155125353, 5779.0062428462115, 5806.187133801355, 5820.0105981982315, 5820.330661973927, 5825.50483208932, 5459.808906688247, 5610.803621873378, 5686.9715651421475, 5691.971540142273, 5706.457886500942], "value": 4182.833857501891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.7586841131962, 698.9510734248602, 723.2875617516746, 785.685725709716, 822.8642274024786, 13797.448102075918, 14555.781663275046, 14641.682248597624, 15136.318865651045, 15504.457343992963, 13825.585232443018, 14063.156210627369, 14107.717845643081, 14307.499237526688, 14326.498572549963, 870.4733636150133, 887.6626881784913, 890.1410139215656, 892.857142857143, 894.217559635319, 872.1365847810654, 884.8495755721543, 886.898006729228, 902.9277657787361, 910.7586489580267, 944.1927152284801, 949.4255975135047, 949.8575213717928, 952.8142012307603, 953.6948176583496, 913.3743385780762, 936.3679516326487, 947.6162154327509, 949.4018768176074, 949.7578117580008, 683.9008343790173, 700.7967689370076, 703.6903762344552, 705.4638474759169, 705.5061456980135, 14574.927125364411, 15109.39562417502, 15304.0, 15327.46353877609, 15360.692786144215, 14185.858141418661, 14341.13953162803, 14393.352299146563, 14446.78329825043, 14465.059771114844, 10498.52756625946, 11589.072874170046, 11670.708232294175, 11787.233829801036, 12310.0, 3648.5986541480415, 3699.3711069118312, 3703.8888833335045, 3719.962800372016, 3848.8845334640005, 96947.0, 97077.0, 97864.51067744616, 98254.50872745662, 98269.50865245699, 10862.891371086345, 10982.0, 11117.27737697047, 11202.21584489078, 11549.960503554721, 22684.0, 22795.974181161888, 22851.0, 23058.192963246205, 23129.42176445569, 7656.540607563453, 7680.884786728204, 7700.845983080307, 7751.7674469766, 7829.569373684388, 3656.0494271489606, 4024.7786371749835, 4173.979130104391, 4212.7472351659, 4274.636655884223, 3590.7666001709804, 3658.5426821647293, 3682.815859207029, 3685.870994515179, 3697.1126929536717, 596.2189531713469, 661.5435349608755, 674.2145400608334, 676.8409423785406, 690.6995456976232, 673.2863165045068, 702.7154002628944, 704.6934583456213, 710.4210068793916, 717.4153065251803, 9790.06994335537, 9878.259130565237, 10500.0, 10561.89438105609, 10636.361818290927, 643.4161719223878, 700.6461736822973, 707.3916431868589, 717.3579646216607, 725.7314793526324, 4095.894108590664, 4188.560201178832, 4705.458872229738, 4978.253262010728, 5017.498250174954, 77019.07452313625, 97045.02954970501, 100905.0, 102092.0, 102301.48849255707, 74702.0, 77967.61016194883, 80256.59871700604, 84839.5758021206, 92034.0, 54764.72617636966, 67158.65682686417, 73175.0, 75973.0, 76935.0, 8928.687495937611, 9294.25645948309, 10589.52347144365, 10606.628767993392, 10843.566257349934, 40986.1802763949, 42006.789966049975, 49279.0, 50229.0, 50906.0, 60132.0, 60698.0, 60889.39110608837, 61566.384336157855, 63031.0, 12557.497700091893, 12825.935870320589, 12900.870991290343, 13143.408546615234, 13309.86690133125, 14427.855721443071, 14470.927645361706, 14786.482473113389, 14828.555143345717, 15401.229938503255, 13415.597532074053, 13522.25627590492, 13670.17978921268, 14068.788968165281, 14514.274286285854, 13547.0, 13670.070175613215, 13814.516491922734, 13817.513899920412, 14312.57062288133, 13365.933170334087, 13447.731045378841, 13451.0, 13874.167549947035, 13924.373403196678, 10364.637237696645, 10842.0, 11170.609028683957, 11266.66200014001, 11466.31202127875, 10247.847951930178, 10986.242399595167, 11103.611373601885, 11115.499802509068, 11136.49885755159], "value": 7483.441777206609, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 118.0, 117.0, 139.0, 173.0, 151.0, 115.0, 116.0, 118.0], "value": 127.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 99.0, 186.0, 144.0, 141.0, 109.0, 115.0, 130.0, 115.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 215.0, 277.0, 263.0, 199.0, 201.0, 195.0, 202.0, 194.0, 197.0], "value": 215.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 59.0, 62.0, 59.0, 58.0, 72.0, 61.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 84.0, 72.0, 70.0, 72.0, 86.0, 101.0, 107.0, 114.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 89.0, 122.0, 85.0, 137.0, 130.0, 106.0, 89.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 152.0, 89.0, 97.0, 90.0, 133.0, 153.0, 124.0, 98.0, 96.0], "value": 112.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 107.0, 94.0, 96.0, 107.0, 112.0, 146.0, 148.0, 101.0, 145.0], "value": 114.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 66.0, 66.0, 65.0, 64.0, 66.0, 64.0, 63.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 73.0, 80.0, 75.0, 71.0, 71.0, 71.0, 75.0, 67.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 90.0, 89.0, 89.0, 88.0, 89.0, 91.0, 87.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 165.0, 156.0, 157.0, 136.0, 138.0, 148.0, 136.0, 202.0, 189.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 176.0, 173.0, 174.0, 176.0, 176.0, 174.0, 171.0, 170.0, 170.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 65.0, 69.0, 67.0, 67.0, 69.0, 67.0, 68.0], "value": 67.7, "unit": "score"}]}]} 14:23:25 INFO - Return code: 0 14:23:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:23:25 ERROR - # TBPL SUCCESS # 14:23:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:23:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:23:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:23:25 INFO - 2017-02-05 14:23:25.396 screenresolution[2059:24277] starting screenresolution argv=screenresolution get 14:23:25 INFO - 2017-02-05 14:23:25.399 screenresolution[2059:24277] Display 0: 1600x1200x32@60 14:23:25 INFO - 2017-02-05 14:23:25.405 screenresolution[2060:24280] starting screenresolution argv=screenresolution list 14:23:25 INFO - Available Modes on Display 0 14:23:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:23:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:23:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:23:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:23:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:23:25 INFO - Intel Iris: 14:23:25 INFO - Chipset Model: Intel Iris 14:23:25 INFO - Type: GPU 14:23:25 INFO - Bus: Built-In 14:23:25 INFO - VRAM (Dynamic, Max): 1536 MB 14:23:25 INFO - Vendor: Intel (0x8086) 14:23:25 INFO - Device ID: 0x0a2e 14:23:25 INFO - Revision ID: 0x0009 14:23:25 INFO - Displays: 14:23:25 INFO - Display: 14:23:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:23:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:23:25 INFO - Display Serial Number: 1600x1200 60 14:23:25 INFO - Main Display: Yes 14:23:25 INFO - Mirror: Off 14:23:25 INFO - Online: Yes 14:23:25 INFO - Rotation: Supported 14:23:25 INFO - Return code: 0 14:23:25 INFO - Running post-action listener: _resource_record_post_action 14:23:25 INFO - [mozharness: 2017-02-05 22:23:25.641829Z] Finished run-tests step (success) 14:23:25 INFO - Running post-run listener: _resource_record_post_run 14:23:25 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32002560; Write bytes: 557283840; Read time: 295; Write time: 1706 14:23:25 INFO - TinderboxPrint: CPU usage
54.4% 14:23:25 INFO - TinderboxPrint: I/O read bytes / time
32,002,560 / 295 14:23:25 INFO - TinderboxPrint: I/O write bytes / time
557,283,840 / 1,706 14:23:25 INFO - TinderboxPrint: CPU idle
2,193.4 (45.6%) 14:23:25 INFO - TinderboxPrint: CPU system
971.0 (20.2%) 14:23:25 INFO - TinderboxPrint: CPU user
1,641.2 (34.2%) 14:23:25 INFO - TinderboxPrint: Swap in / out
278,585,344 / 0 14:23:25 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 235463168; Write bytes: 230918144; Read time: 17685; Write time: 464 14:23:25 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 32002560; Write bytes: 301613568; Read time: 295; Write time: 1193 14:23:26 INFO - Running post-run listener: _upload_blobber_files 14:23:26 INFO - Blob upload gear active. 14:23:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:23:26 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 14:23:26 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:23:26 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:23:26 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:23:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:27 INFO - (blobuploader) - INFO - Done attempting. 14:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:23:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:28 INFO - (blobuploader) - INFO - Done attempting. 14:23:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:23:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:23:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:29 INFO - (blobuploader) - INFO - Done attempting. 14:23:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:23:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:23:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:31 INFO - (blobuploader) - INFO - Done attempting. 14:23:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:31 INFO - Return code: 0 14:23:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:23:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7768a8d768287021ed30868915cb28ad559d47cd4776809ddb3f6e3bb0c9ccdb87ed947ed5da480820e2744d7efff1bda377c2a6cf80e5fda24b527fd74d60c4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3859ea5f1881eea482a03c0a27362853718a68072906f2fb973f644b3994a18c5c538726f69ba9916bd24a9f5db056061db84e8b73b365f5a07b36db49cad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e2782cb61a79ec9a0353ef66bc8f25d93380ec27f2701a1521d7c6a33fcd8240039b2000057f37bb5a5cf637e86a286240e693d56efdc89853ba89e990b11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b08cdb55096be1c81786c577010f9ca16e44735bd532bf2c9cf52cefa115050bbb027f50cfee710cd8ae76d1b3ecd185d2ca4bde9d7ea618a25182378ec5329"} 14:23:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:23:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:23:31 INFO - Contents: 14:23:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7768a8d768287021ed30868915cb28ad559d47cd4776809ddb3f6e3bb0c9ccdb87ed947ed5da480820e2744d7efff1bda377c2a6cf80e5fda24b527fd74d60c4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3859ea5f1881eea482a03c0a27362853718a68072906f2fb973f644b3994a18c5c538726f69ba9916bd24a9f5db056061db84e8b73b365f5a07b36db49cad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e2782cb61a79ec9a0353ef66bc8f25d93380ec27f2701a1521d7c6a33fcd8240039b2000057f37bb5a5cf637e86a286240e693d56efdc89853ba89e990b11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b08cdb55096be1c81786c577010f9ca16e44735bd532bf2c9cf52cefa115050bbb027f50cfee710cd8ae76d1b3ecd185d2ca4bde9d7ea618a25182378ec5329"} 14:23:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:23:31 INFO - Copying logs to upload dir... 14:23:31 INFO - mkdir: /builds/slave/test/build/upload/logs 14:23:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.035073 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-05 14:23:31.568497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 14:23:31.571711) ========= 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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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/Firefox/sha512/7768a8d768287021ed30868915cb28ad559d47cd4776809ddb3f6e3bb0c9ccdb87ed947ed5da480820e2744d7efff1bda377c2a6cf80e5fda24b527fd74d60c4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3859ea5f1881eea482a03c0a27362853718a68072906f2fb973f644b3994a18c5c538726f69ba9916bd24a9f5db056061db84e8b73b365f5a07b36db49cad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e2782cb61a79ec9a0353ef66bc8f25d93380ec27f2701a1521d7c6a33fcd8240039b2000057f37bb5a5cf637e86a286240e693d56efdc89853ba89e990b11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b08cdb55096be1c81786c577010f9ca16e44735bd532bf2c9cf52cefa115050bbb027f50cfee710cd8ae76d1b3ecd185d2ca4bde9d7ea618a25182378ec5329"} build_url:https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/UgBSbHdtQs-6XlwGzLwMAw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7768a8d768287021ed30868915cb28ad559d47cd4776809ddb3f6e3bb0c9ccdb87ed947ed5da480820e2744d7efff1bda377c2a6cf80e5fda24b527fd74d60c4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3859ea5f1881eea482a03c0a27362853718a68072906f2fb973f644b3994a18c5c538726f69ba9916bd24a9f5db056061db84e8b73b365f5a07b36db49cad4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e2782cb61a79ec9a0353ef66bc8f25d93380ec27f2701a1521d7c6a33fcd8240039b2000057f37bb5a5cf637e86a286240e693d56efdc89853ba89e990b11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b08cdb55096be1c81786c577010f9ca16e44735bd532bf2c9cf52cefa115050bbb027f50cfee710cd8ae76d1b3ecd185d2ca4bde9d7ea618a25182378ec5329"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 14:23:31.605499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:23:31.605820) ========= 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.ok7id9vDbF/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.4EHJ8eQPmr/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005071 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:23:31.654269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 14:23:31.654603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 14:23:31.655089) ========= ========= Total master_lag: 0.38 =========