builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0201 starttime: 1484304905.79 results: success (0) buildid: 20170113011916 builduid: 5ad6546c740e4c1eb15bf18aaa68da23 revision: eca7348f32d8410559e342bff1a7698ceb2e9a30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.789306) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.789732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.790017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.814673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.814972) ========= 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.fHUSz82418/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.i6QVmIMlnC/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-01-13 02:55:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.4M=0s 2017-01-13 02:55:05 (66.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.925978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.926290) ========= 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.fHUSz82418/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.i6QVmIMlnC/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.024132 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:05.975504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-13 02:55:05.975837) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eca7348f32d8410559e342bff1a7698ceb2e9a30 --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 eca7348f32d8410559e342bff1a7698ceb2e9a30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fHUSz82418/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.i6QVmIMlnC/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-01-13 02:55:06,060 truncating revision to first 12 chars 2017-01-13 02:55:06,060 Setting DEBUG logging. 2017-01-13 02:55:06,060 attempt 1/10 2017-01-13 02:55:06,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eca7348f32d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 02:55:07,157 unpacking tar archive at: mozilla-central-eca7348f32d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.384814 ========= master_lag: 2.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-13 02:55:09.614178) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:09.614502) ========= script_repo_revision: eca7348f32d8410559e342bff1a7698ceb2e9a30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:09.614895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:09.615156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:09.636071) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-13 02:55:09.636342) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.fHUSz82418/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.i6QVmIMlnC/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:55:09 INFO - MultiFileLogger online at 20170113 02:55:09 in /builds/slave/test 02:55:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:55:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:09 INFO - {'append_to_log': False, 02:55:09 INFO - 'base_work_dir': '/builds/slave/test', 02:55:09 INFO - 'blob_upload_branch': 'Firefox', 02:55:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:09 INFO - 'branch': 'Firefox', 02:55:09 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:09 INFO - 'config_files': ('talos/mac_config.py',), 02:55:09 INFO - 'default_actions': ('clobber', 02:55:09 INFO - 'read-buildbot-config', 02:55:09 INFO - 'download-and-extract', 02:55:09 INFO - 'populate-webroot', 02:55:09 INFO - 'create-virtualenv', 02:55:09 INFO - 'install', 02:55:09 INFO - 'run-tests'), 02:55:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:09 INFO - 'download_minidump_stackwalk': True, 02:55:09 INFO - 'download_symbols': 'ondemand', 02:55:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:55:09 INFO - 'tooltool.py': '/tools/tooltool.py', 02:55:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:55:09 INFO - '/tools/misc-python/virtualenv.py')}, 02:55:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:09 INFO - 'installer_path': 'installer.exe', 02:55:09 INFO - 'log_level': 'info', 02:55:09 INFO - 'log_name': 'talos', 02:55:09 INFO - 'log_to_console': True, 02:55:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:55:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:55:09 INFO - 'opt_config_files': (), 02:55:09 INFO - 'pip_index': False, 02:55:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:09 INFO - 'cmd': ('bash', 02:55:09 INFO - '-c', 02:55:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:09 INFO - 'enabled': True, 02:55:09 INFO - 'halt_on_failure': False, 02:55:09 INFO - 'name': 'check_screen_resolution'},), 02:55:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:09 INFO - 'cmd': ('bash', 02:55:09 INFO - '-c', 02:55:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:09 INFO - 'enabled': True, 02:55:09 INFO - 'halt_on_failure': False, 02:55:09 INFO - 'name': 'check_screen_resolution'},), 02:55:09 INFO - 'run_cmd_checks_enabled': True, 02:55:09 INFO - 'sps_profile': False, 02:55:09 INFO - 'sps_profile_interval': 0, 02:55:09 INFO - 'suite': 'dromaeojs', 02:55:09 INFO - 'system_bits': '32', 02:55:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:09 INFO - 'title': 't-yosemite-r7-0201', 02:55:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:09 INFO - 'use_talos_json': True, 02:55:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:09 INFO - 'work_dir': 'build'} 02:55:09 INFO - [mozharness: 2017-01-13 10:55:09.841173Z] Running clobber step. 02:55:09 INFO - Running pre-action listener: _resource_record_pre_action 02:55:09 INFO - Running main action method: clobber 02:55:09 INFO - rmtree: /builds/slave/test/build 02:55:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:11 INFO - Running post-action listener: _resource_record_post_action 02:55:11 INFO - [mozharness: 2017-01-13 10:55:11.479815Z] Finished clobber step (success) 02:55:11 INFO - [mozharness: 2017-01-13 10:55:11.480004Z] Running read-buildbot-config step. 02:55:11 INFO - Running pre-action listener: _resource_record_pre_action 02:55:11 INFO - Running main action method: read_buildbot_config 02:55:11 INFO - Using buildbot properties: 02:55:11 INFO - { 02:55:11 INFO - "project": "", 02:55:11 INFO - "product": "firefox", 02:55:11 INFO - "script_repo_revision": "production", 02:55:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:55:11 INFO - "repository": "", 02:55:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:55:11 INFO - "buildid": "20170113011916", 02:55:11 INFO - "pgo_build": "False", 02:55:11 INFO - "basedir": "/builds/slave/test", 02:55:11 INFO - "buildnumber": 10, 02:55:11 INFO - "slavename": "t-yosemite-r7-0201", 02:55:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:55:11 INFO - "platform": "yosemite_r7", 02:55:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:55:11 INFO - "branch": "mozilla-central", 02:55:11 INFO - "repo_path": "mozilla-central", 02:55:11 INFO - "revision": "eca7348f32d8410559e342bff1a7698ceb2e9a30", 02:55:11 INFO - "stage_platform": "macosx64", 02:55:11 INFO - "builduid": "5ad6546c740e4c1eb15bf18aaa68da23", 02:55:11 INFO - "slavebuilddir": "test" 02:55:11 INFO - } 02:55:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 02:55:11 INFO - Running post-action listener: _resource_record_post_action 02:55:11 INFO - [mozharness: 2017-01-13 10:55:11.483896Z] Finished read-buildbot-config step (success) 02:55:11 INFO - [mozharness: 2017-01-13 10:55:11.484023Z] Running download-and-extract step. 02:55:11 INFO - Running pre-action listener: _resource_record_pre_action 02:55:11 INFO - Running main action method: download_and_extract 02:55:11 INFO - mkdir: /builds/slave/test/build/tests 02:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:11 INFO - trying https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 02:55:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:55:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 02:55:12 INFO - Downloaded 1199 bytes. 02:55:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:55:12 INFO - Using the following test package requirements: 02:55:12 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:55:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 02:55:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 02:55:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'jsshell-mac.zip'], 02:55:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 02:55:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:55:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 02:55:12 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 02:55:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 02:55:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:12 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 02:55:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:55:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:55:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:55:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:55:13 INFO - Expected file size: 16317025 02:55:13 INFO - Obtained file size: 16317025 02:55:20 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:55:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:55:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:55:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:55:21 INFO - Expected file size: 16317025 02:55:21 INFO - Obtained file size: 16317025 02:55:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 02:55:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:55:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 02:55:28 INFO - Expected file size: 14403555 02:55:28 INFO - Obtained file size: 14403555 02:55: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')]} 02:55:29 INFO - trying https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:55:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 02:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 02:55:31 INFO - Downloaded 70078676 bytes. 02:55:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:55:31 INFO - mkdir: /builds/slave/test/properties 02:55:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:31 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:31 INFO - Contents: 02:55:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:55:31 INFO - Running post-action listener: _resource_record_post_action 02:55:31 INFO - Running post-action listener: set_extra_try_arguments 02:55:31 INFO - [mozharness: 2017-01-13 10:55:31.770230Z] Finished download-and-extract step (success) 02:55:31 INFO - [mozharness: 2017-01-13 10:55:31.770355Z] Running populate-webroot step. 02:55:31 INFO - Running pre-action listener: _resource_record_pre_action 02:55:31 INFO - Running main action method: populate_webroot 02:55:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:55:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:55:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:55:31 INFO - '--tppagecycles', 02:55:31 INFO - '7'], 02:55:31 INFO - 'tests': ['tsvgm']}}, 02:55:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:55:31 INFO - 'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:55:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:55:31 INFO - 'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['damp', 'tps']}, 02:55:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:55:31 INFO - 'tests': ['damp', 'tps']}, 02:55:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['dromaeo_dom']}, 02:55:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['basic_compositor_video']}, 02:55:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:55:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['a11yr', 02:55:31 INFO - 'ts_paint', 02:55:31 INFO - 'tpaint', 02:55:31 INFO - 'sessionrestore', 02:55:31 INFO - 'sessionrestore_no_auto_restore', 02:55:31 INFO - 'tabpaint']}, 02:55:31 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:31 INFO - 'ts_paint', 02:55:31 INFO - 'tpaint', 02:55:31 INFO - 'sessionrestore', 02:55:31 INFO - 'sessionrestore_no_auto_restore', 02:55:31 INFO - 'tabpaint']}, 02:55:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:55:31 INFO - 'ts_paint', 02:55:31 INFO - 'tpaint', 02:55:31 INFO - 'sessionrestore', 02:55:31 INFO - 'sessionrestore_no_auto_restore', 02:55:31 INFO - 'tabpaint']}, 02:55:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:55:31 INFO - 'ts_paint', 02:55:31 INFO - 'tpaint', 02:55:31 INFO - 'sessionrestore', 02:55:31 INFO - 'sessionrestore_no_auto_restore', 02:55:31 INFO - 'tabpaint']}, 02:55:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['a11yr', 02:55:31 INFO - 'ts_paint', 02:55:31 INFO - 'tpaint', 02:55:31 INFO - 'sessionrestore', 02:55:31 INFO - 'sessionrestore_no_auto_restore', 02:55:31 INFO - 'tabpaint']}, 02:55:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['a11yr', 02:55:31 INFO - 'ts_paint', 02:55:31 INFO - 'tpaint', 02:55:31 INFO - 'sessionrestore', 02:55:31 INFO - 'sessionrestore_no_auto_restore', 02:55:31 INFO - 'tabpaint']}, 02:55:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['tsvgx', 02:55:31 INFO - 'tsvgr_opacity', 02:55:31 INFO - 'tart', 02:55:31 INFO - 'tscrollx', 02:55:31 INFO - 'cart', 02:55:31 INFO - 'tsvg_static']}, 02:55:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:31 INFO - 'tsvgr_opacity', 02:55:31 INFO - 'tart', 02:55:31 INFO - 'tscrollx', 02:55:31 INFO - 'cart', 02:55:31 INFO - 'tsvg_static']}, 02:55:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:55:31 INFO - 'talos_options': ['--disable-e10s'], 02:55:31 INFO - 'tests': ['tp5o']}, 02:55:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:55:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:55:31 INFO - 'talos_options': ['--disable-e10s', 02:55:31 INFO - '--xperf_path', 02:55:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:31 INFO - 'tests': ['tp5n']}, 02:55:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:55:31 INFO - 'talos_options': ['--xperf_path', 02:55:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:31 INFO - 'tests': ['tp5n']}}, 02:55:31 INFO - 'talos.zip': {'path': '', 02:55:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:55:31 INFO - Running post-action listener: _resource_record_post_action 02:55:31 INFO - [mozharness: 2017-01-13 10:55:31.788293Z] Finished populate-webroot step (success) 02:55:31 INFO - [mozharness: 2017-01-13 10:55:31.788424Z] Running create-virtualenv step. 02:55:31 INFO - Running pre-action listener: _resource_record_pre_action 02:55:31 INFO - Running main action method: create_virtualenv 02:55:31 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:55:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:55:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:31 INFO - Using real prefix '/tools/python27' 02:55:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:32 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:35 INFO - Installing pip.................done. 02:55:35 INFO - Return code: 0 02:55:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:55:35 INFO - Reading from file tmpfile_stdout 02:55:35 INFO - Output received: 02:55:35 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) 02:55:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:35 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 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:35 INFO - 'HOME': '/Users/cltbld', 02:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:35 INFO - 'LOGNAME': 'cltbld', 02:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:35 INFO - 'MOZ_NO_REMOTE': '1', 02:55:35 INFO - 'NO_EM_RESTART': '1', 02:55:35 INFO - 'PAGER': '/bin/cat', 02:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:35 INFO - 'PWD': '/builds/slave/test', 02:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:35 INFO - 'SHELL': '/bin/bash', 02:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:35 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:35 INFO - 'USER': 'cltbld', 02:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:35 INFO - 'XPC_FLAGS': '0x0', 02:55:35 INFO - 'XPC_SERVICE_NAME': '0', 02:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:55:35 INFO - Cleaning up... 02:55:36 INFO - Return code: 0 02:55:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:36 INFO - 'HOME': '/Users/cltbld', 02:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:36 INFO - 'LOGNAME': 'cltbld', 02:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:36 INFO - 'MOZ_NO_REMOTE': '1', 02:55:36 INFO - 'NO_EM_RESTART': '1', 02:55:36 INFO - 'PAGER': '/bin/cat', 02:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:36 INFO - 'PWD': '/builds/slave/test', 02:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:36 INFO - 'SHELL': '/bin/bash', 02:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:36 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:36 INFO - 'USER': 'cltbld', 02:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:36 INFO - 'XPC_FLAGS': '0x0', 02:55:36 INFO - 'XPC_SERVICE_NAME': '0', 02:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:36 INFO - Downloading/unpacking psutil>=3.1.1 02:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:55:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:39 INFO - Installing collected packages: psutil 02:55:39 INFO - Running setup.py install for psutil 02:55:40 INFO - building 'psutil._psutil_osx' extension 02:55:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:55:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:55:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:55:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:55:40 INFO - building 'psutil._psutil_posix' extension 02:55:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:55:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:55:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:55:40 INFO - ^ 02:55:40 INFO - 1 warning generated. 02:55:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:55:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:40 INFO - Successfully installed psutil 02:55:40 INFO - Cleaning up... 02:55:40 INFO - Return code: 0 02:55:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:40 INFO - 'HOME': '/Users/cltbld', 02:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:40 INFO - 'LOGNAME': 'cltbld', 02:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:40 INFO - 'MOZ_NO_REMOTE': '1', 02:55:40 INFO - 'NO_EM_RESTART': '1', 02:55:40 INFO - 'PAGER': '/bin/cat', 02:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:40 INFO - 'PWD': '/builds/slave/test', 02:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:40 INFO - 'SHELL': '/bin/bash', 02:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:40 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:40 INFO - 'USER': 'cltbld', 02:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:40 INFO - 'XPC_FLAGS': '0x0', 02:55:40 INFO - 'XPC_SERVICE_NAME': '0', 02:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:55:43 INFO - Installing collected packages: mozsystemmonitor 02:55:43 INFO - Running setup.py install for mozsystemmonitor 02:55:43 INFO - Successfully installed mozsystemmonitor 02:55:43 INFO - Cleaning up... 02:55:43 INFO - Return code: 0 02:55:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:43 INFO - 'HOME': '/Users/cltbld', 02:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:43 INFO - 'LOGNAME': 'cltbld', 02:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:43 INFO - 'MOZ_NO_REMOTE': '1', 02:55:43 INFO - 'NO_EM_RESTART': '1', 02:55:43 INFO - 'PAGER': '/bin/cat', 02:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:43 INFO - 'PWD': '/builds/slave/test', 02:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:43 INFO - 'SHELL': '/bin/bash', 02:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:43 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:43 INFO - 'USER': 'cltbld', 02:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:43 INFO - 'XPC_FLAGS': '0x0', 02:55:43 INFO - 'XPC_SERVICE_NAME': '0', 02:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:44 INFO - Downloading/unpacking jsonschema==2.5.1 02:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:55:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:47 INFO - Downloading functools32-3.2.3-2.tar.gz 02:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:55:47 INFO - warning: no files found matching '*.txt' 02:55:47 INFO - no previously-included directories found matching 'build' 02:55:47 INFO - no previously-included directories found matching 'dist' 02:55:47 INFO - no previously-included directories found matching '.git*' 02:55:47 INFO - Installing collected packages: jsonschema, functools32 02:55:47 INFO - Running setup.py install for functools32 02:55:47 INFO - warning: no files found matching '*.txt' 02:55:47 INFO - no previously-included directories found matching 'build' 02:55:47 INFO - no previously-included directories found matching 'dist' 02:55:47 INFO - no previously-included directories found matching '.git*' 02:55:47 INFO - Successfully installed jsonschema functools32 02:55:47 INFO - Cleaning up... 02:55:47 INFO - Return code: 0 02:55:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:47 INFO - 'HOME': '/Users/cltbld', 02:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:47 INFO - 'LOGNAME': 'cltbld', 02:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:47 INFO - 'MOZ_NO_REMOTE': '1', 02:55:47 INFO - 'NO_EM_RESTART': '1', 02:55:47 INFO - 'PAGER': '/bin/cat', 02:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:47 INFO - 'PWD': '/builds/slave/test', 02:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:47 INFO - 'SHELL': '/bin/bash', 02:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:47 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:47 INFO - 'USER': 'cltbld', 02:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:47 INFO - 'XPC_FLAGS': '0x0', 02:55:47 INFO - 'XPC_SERVICE_NAME': '0', 02:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:55:47 INFO - Cleaning up... 02:55:47 INFO - Return code: 0 02:55:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:47 INFO - 'HOME': '/Users/cltbld', 02:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:47 INFO - 'LOGNAME': 'cltbld', 02:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:47 INFO - 'MOZ_NO_REMOTE': '1', 02:55:47 INFO - 'NO_EM_RESTART': '1', 02:55:47 INFO - 'PAGER': '/bin/cat', 02:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:47 INFO - 'PWD': '/builds/slave/test', 02:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:47 INFO - 'SHELL': '/bin/bash', 02:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:47 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:47 INFO - 'USER': 'cltbld', 02:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:47 INFO - 'XPC_FLAGS': '0x0', 02:55:47 INFO - 'XPC_SERVICE_NAME': '0', 02:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:55:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:51 INFO - Downloading docopt-0.6.1.tar.gz 02:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:55:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:55:52 INFO - Running setup.py install for blobuploader 02:55:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:55:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:55:52 INFO - Running setup.py install for requests 02:55:52 INFO - Running setup.py install for docopt 02:55:52 INFO - Successfully installed blobuploader requests docopt 02:55:52 INFO - Cleaning up... 02:55:52 INFO - Return code: 0 02:55:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:52 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 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:52 INFO - 'HOME': '/Users/cltbld', 02:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:52 INFO - 'LOGNAME': 'cltbld', 02:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:52 INFO - 'MOZ_NO_REMOTE': '1', 02:55:52 INFO - 'NO_EM_RESTART': '1', 02:55:52 INFO - 'PAGER': '/bin/cat', 02:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:52 INFO - 'PWD': '/builds/slave/test', 02:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:52 INFO - 'SHELL': '/bin/bash', 02:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:52 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:52 INFO - 'USER': 'cltbld', 02:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:52 INFO - 'XPC_FLAGS': '0x0', 02:55:52 INFO - 'XPC_SERVICE_NAME': '0', 02:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-5OVcnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-afwqKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-lL5xYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-xH77Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-L1AcaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-awNYOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-YALcUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-XWmb19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Bqlf1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-mN3qxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Hwvrp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Zvnnav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-XneeLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-sryj2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-BKzhuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-kfEYT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-cuMvqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:55:54 INFO - Running setup.py install for manifestparser 02:55:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:55:55 INFO - Running setup.py install for mozcrash 02:55:55 INFO - Running setup.py install for mozdebug 02:55:55 INFO - Running setup.py install for mozdevice 02:55:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:55:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:55:55 INFO - Running setup.py install for mozfile 02:55:55 INFO - Running setup.py install for mozhttpd 02:55:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:55:55 INFO - Running setup.py install for mozinfo 02:55:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Running setup.py install for mozInstall 02:55:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Running setup.py install for mozleak 02:55:56 INFO - Running setup.py install for mozlog 02:55:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Running setup.py install for moznetwork 02:55:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Running setup.py install for mozprocess 02:55:56 INFO - Running setup.py install for mozprofile 02:55:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:55:56 INFO - Running setup.py install for mozrunner 02:55:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:55:57 INFO - Running setup.py install for mozscreenshot 02:55:57 INFO - Running setup.py install for moztest 02:55:57 INFO - Running setup.py install for mozversion 02:55:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:55:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:55:57 INFO - Cleaning up... 02:55:57 INFO - Return code: 0 02:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:57 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 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:57 INFO - 'HOME': '/Users/cltbld', 02:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:57 INFO - 'LOGNAME': 'cltbld', 02:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:57 INFO - 'MOZ_NO_REMOTE': '1', 02:55:57 INFO - 'NO_EM_RESTART': '1', 02:55:57 INFO - 'PAGER': '/bin/cat', 02:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:57 INFO - 'PWD': '/builds/slave/test', 02:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:57 INFO - 'SHELL': '/bin/bash', 02:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:55:57 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:57 INFO - 'USER': 'cltbld', 02:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:57 INFO - 'XPC_FLAGS': '0x0', 02:55:57 INFO - 'XPC_SERVICE_NAME': '0', 02:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:57 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-zpSyOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:57 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-mu_O3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:58 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)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Fi7Onn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-wkdWwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:58 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)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-kCHglm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-sVkEt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-DgEbtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-afH9lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-eRRU_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-XIPufp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-AdQqty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-bYv3Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:59 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)) 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-hB9r5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-wLcuFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:59 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)) 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-tkJvRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-_U2pnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:59 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)) 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-2vbYGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:55:59 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)) 02:55:59 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)) 02:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:55:59 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)) 02:55:59 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)) 02:55:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:02 INFO - Downloading blessings-1.6.tar.gz 02:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:02 INFO - Installing collected packages: blessings 02:56:02 INFO - Running setup.py install for blessings 02:56:02 INFO - Successfully installed blessings 02:56:02 INFO - Cleaning up... 02:56:02 INFO - Return code: 0 02:56:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:02 INFO - Reading from file tmpfile_stdout 02:56:02 INFO - Current package versions: 02:56:02 INFO - blessings == 1.6 02:56:02 INFO - blobuploader == 1.2.4 02:56:02 INFO - docopt == 0.6.1 02:56:02 INFO - functools32 == 3.2.3-2 02:56:02 INFO - jsonschema == 2.5.1 02:56:02 INFO - manifestparser == 1.1 02:56:02 INFO - mozInstall == 1.12 02:56:02 INFO - mozcrash == 1.0 02:56:02 INFO - mozdebug == 0.1 02:56:02 INFO - mozdevice == 0.49 02:56:02 INFO - mozfile == 1.2 02:56:02 INFO - mozhttpd == 0.7 02:56:02 INFO - mozinfo == 0.9 02:56:02 INFO - mozleak == 0.1 02:56:02 INFO - mozlog == 3.4 02:56:02 INFO - moznetwork == 0.27 02:56:02 INFO - mozprocess == 0.24 02:56:02 INFO - mozprofile == 0.28 02:56:02 INFO - mozrunner == 6.13 02:56:02 INFO - mozscreenshot == 0.1 02:56:02 INFO - mozsystemmonitor == 0.3 02:56:02 INFO - moztest == 0.8 02:56:02 INFO - mozversion == 1.4 02:56:02 INFO - psutil == 3.1.1 02:56:02 INFO - requests == 1.2.3 02:56:02 INFO - wsgiref == 0.1.2 02:56:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:03 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 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:03 INFO - 'HOME': '/Users/cltbld', 02:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:03 INFO - 'LOGNAME': 'cltbld', 02:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:03 INFO - 'MOZ_NO_REMOTE': '1', 02:56:03 INFO - 'NO_EM_RESTART': '1', 02:56:03 INFO - 'PAGER': '/bin/cat', 02:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:03 INFO - 'PWD': '/builds/slave/test', 02:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:03 INFO - 'SHELL': '/bin/bash', 02:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:56:03 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:03 INFO - 'USER': 'cltbld', 02:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:03 INFO - 'XPC_FLAGS': '0x0', 02:56:03 INFO - 'XPC_SERVICE_NAME': '0', 02:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:04 INFO - Cleaning up... 02:56:04 INFO - Return code: 0 02:56:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a51bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a51e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd693d90de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, '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.fHUSz82418/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.i6QVmIMlnC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:56: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 02:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:04 INFO - 'HOME': '/Users/cltbld', 02:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:04 INFO - 'LOGNAME': 'cltbld', 02:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:04 INFO - 'MOZ_NO_REMOTE': '1', 02:56:04 INFO - 'NO_EM_RESTART': '1', 02:56:04 INFO - 'PAGER': '/bin/cat', 02:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:04 INFO - 'PWD': '/builds/slave/test', 02:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:04 INFO - 'SHELL': '/bin/bash', 02:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:56:04 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:04 INFO - 'USER': 'cltbld', 02:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:04 INFO - 'XPC_FLAGS': '0x0', 02:56:04 INFO - 'XPC_SERVICE_NAME': '0', 02:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:04 INFO - Cleaning up... 02:56:04 INFO - Return code: 0 02:56:04 INFO - Running post-action listener: _resource_record_post_action 02:56:04 INFO - Running post-action listener: _start_resource_monitoring 02:56:04 INFO - Starting resource monitoring. 02:56:04 INFO - [mozharness: 2017-01-13 10:56:04.825595Z] Finished create-virtualenv step (success) 02:56:04 INFO - [mozharness: 2017-01-13 10:56:04.826573Z] Running install step. 02:56:04 INFO - Running pre-action listener: _resource_record_pre_action 02:56:04 INFO - Running main action method: install 02:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:05 INFO - Reading from file tmpfile_stdout 02:56:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:05 INFO - Reading from file tmpfile_stdout 02:56:05 INFO - Output received: 02:56:05 INFO - Usage: mozinstall [options] installer 02:56:05 INFO - Options: 02:56:05 INFO - -h, --help show this help message and exit 02:56:05 INFO - -d DEST, --destination=DEST 02:56:05 INFO - Directory to install application into. [default: 02:56:05 INFO - "/builds/slave/test"] 02:56:05 INFO - --app=APP Application being installed. [default: firefox] 02:56:05 INFO - mkdir: /builds/slave/test/build/application 02:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:56:27 INFO - Reading from file tmpfile_stdout 02:56:27 INFO - Output received: 02:56:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:56:27 INFO - Running post-action listener: _resource_record_post_action 02:56:27 INFO - [mozharness: 2017-01-13 10:56:27.045287Z] Finished install step (success) 02:56:27 INFO - [mozharness: 2017-01-13 10:56:27.045412Z] Running run-tests step. 02:56:27 INFO - Running pre-action listener: _resource_record_pre_action 02:56:27 INFO - Running main action method: run_tests 02:56:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:27 INFO - 2017-01-13 02:56:27.058 screenresolution[7096:135275] starting screenresolution argv=screenresolution get 02:56:27 INFO - 2017-01-13 02:56:27.060 screenresolution[7096:135275] Display 0: 1600x1200x32@60 02:56:27 INFO - 2017-01-13 02:56:27.065 screenresolution[7097:135277] starting screenresolution argv=screenresolution list 02:56:27 INFO - Available Modes on Display 0 02:56:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:27 INFO - Intel Iris: 02:56:27 INFO - Chipset Model: Intel Iris 02:56:27 INFO - Type: GPU 02:56:27 INFO - Bus: Built-In 02:56:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:27 INFO - Vendor: Intel (0x8086) 02:56:27 INFO - Device ID: 0x0a2e 02:56:27 INFO - Revision ID: 0x0009 02:56:27 INFO - Displays: 02:56:27 INFO - Display: 02:56:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:27 INFO - Display Serial Number: 1600x1200 60 02:56:27 INFO - Main Display: Yes 02:56:27 INFO - Mirror: Off 02:56:27 INFO - Online: Yes 02:56:27 INFO - Rotation: Supported 02:56:27 INFO - Return code: 0 02:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:27 INFO - Python 2.7.3 02:56:27 INFO - Return code: 0 02:56:27 INFO - grabbing minidump binary from tooltool 02:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2f9d30>, '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 0x10a220db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2eebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:56:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:56:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:56:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:27 INFO - Return code: 0 02:56:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:56:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:56:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0201 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fHUSz82418/Render', 02:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:27 INFO - 'HOME': '/Users/cltbld', 02:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:27 INFO - 'LOGNAME': 'cltbld', 02:56:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:27 INFO - 'MOZ_NO_REMOTE': '1', 02:56:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:27 INFO - 'NO_EM_RESTART': '1', 02:56:27 INFO - 'PAGER': '/bin/cat', 02:56:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:27 INFO - 'PWD': '/builds/slave/test', 02:56:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:27 INFO - 'SHELL': '/bin/bash', 02:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i6QVmIMlnC/Listeners', 02:56:27 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:27 INFO - 'USER': 'cltbld', 02:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:27 INFO - 'XPC_FLAGS': '0x0', 02:56:27 INFO - 'XPC_SERVICE_NAME': '0', 02:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:56:27 INFO - mozversion application_buildid: 20170113011916 02:56:27 INFO - mozversion application_changeset: eca7348f32d8410559e342bff1a7698ceb2e9a30 02:56:27 INFO - mozversion application_display_name: Nightly 02:56:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:27 INFO - mozversion application_name: Firefox 02:56:27 INFO - mozversion application_remotingname: firefox 02:56:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:56:27 INFO - mozversion application_vendor: Mozilla 02:56:27 INFO - mozversion application_version: 53.0a1 02:56:27 INFO - mozversion platform_buildid: 20170113011916 02:56:27 INFO - mozversion platform_changeset: eca7348f32d8410559e342bff1a7698ceb2e9a30 02:56:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:56:27 INFO - mozversion platform_version: 53.0a1 02:56:27 INFO - using testdate: 1484304987 02:56:27 INFO - actual date: 1484304987 02:56:27 INFO - starting webserver on 'localhost:49770' 02:56:27 INFO - SUITE-START | Running 2 tests 02:56:27 INFO - TEST-START | dromaeo_css 02:56:27 INFO - operating with platform_type : mac_ 02:56:27 INFO - Initialising browser for dromaeo_css test... 02:56:27 INFO - TEST-INFO | started process 7107 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpZpMHBP/profile http://localhost:49770/getInfo.html) 02:56:30 INFO - PROCESS | 7107 | __metrics Screen width/height:1600/1200 02:56:30 INFO - PROCESS | 7107 | colorDepth:24 02:56:30 INFO - PROCESS | 7107 | Browser inner width/height: 1024/689 02:56:30 INFO - PROCESS | 7107 | __metrics 02:56:30 INFO - PROCESS | 7107 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:56:30 INFO - PROCESS | 7107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:56:30 INFO - TEST-INFO | 7107: exit 0 02:56:30 INFO - Browser initialized. 02:56:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:30 INFO - TEST-INFO | started process 7109 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpZpMHBP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:43 INFO - PROCESS | 7109 | RSS: Main: 235507712 02:56:43 INFO - PROCESS | 7109 | 02:59:47 INFO - PROCESS | 7109 | Cycle 1(1): loaded http://localhost:49770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49770/tests/dromaeo/cssquery-ext.html) 02:59:48 INFO - PROCESS | 7109 | RSS: Main: 345219072 02:59:48 INFO - PROCESS | 7109 | 03:01:32 INFO - PROCESS | 7109 | ************************* 03:01:32 INFO - PROCESS | 7109 | A coding exception was thrown and uncaught in a Task. 03:01:32 INFO - PROCESS | 7109 | 03:01:32 ERROR - PROCESS | 7109 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:01:32 INFO - PROCESS | 7109 | Full stack: 03:01:32 INFO - PROCESS | 7109 | ************************* 03:02:51 INFO - PROCESS | 7109 | Cycle 1(1): loaded http://localhost:49770/tests/dromaeo/cssquery-ext.html (next: http://localhost:49770/tests/dromaeo/cssquery-jquery.html) 03:02:52 INFO - PROCESS | 7109 | RSS: Main: 366452736 03:02:52 INFO - PROCESS | 7109 | 03:05:54 INFO - PROCESS | 7109 | Cycle 1(1): loaded http://localhost:49770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49770/tests/dromaeo/cssquery-mootools.html) 03:05:55 INFO - PROCESS | 7109 | RSS: Main: 339529728 03:05:55 INFO - PROCESS | 7109 | 03:08:57 INFO - PROCESS | 7109 | Cycle 1(1): loaded http://localhost:49770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49770/tests/dromaeo/cssquery-prototype.html) 03:08:58 INFO - PROCESS | 7109 | RSS: Main: 340115456 03:08:58 INFO - PROCESS | 7109 | 03:12:01 INFO - PROCESS | 7109 | Cycle 1(1): loaded http://localhost:49770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49770/tests/dromaeo/cssquery-yui.html) 03:12:02 INFO - PROCESS | 7109 | RSS: Main: 323563520 03:12:02 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | Cycle 1(1): loaded http://localhost:49770/tests/dromaeo/cssquery-yui.html (next: http://localhost:49770/tests/dromaeo/cssquery-dojo.html) 03:15:05 INFO - PROCESS | 7109 | RSS: Main: 414552064 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | __start_tp_report 03:15:05 INFO - PROCESS | 7109 | _x_x_mozilla_page_load 03:15:05 INFO - PROCESS | 7109 | _x_x_mozilla_page_load_details 03:15:05 INFO - PROCESS | 7109 | |i|pagename|runs| 03:15:05 INFO - PROCESS | 7109 | |0;dojo.html;3253.6258330292017;3294.8187849668257;3311.6191637961633;3320.9003729888113;3357.4628059510483;5601.383847776751;5683.602147849652;5716.22830917826;5722.685252311116;5741.913871291934;5697.715114244292;5721.141828725693;5807.883842323151;5813.854653633662;5842.47417732404;5149.74251287436;5177.275181474578;5196.0647083524955;5253.290805741233;5302.178162384817;5313.574914006889;5326.813561525348;5327.094393953037;5330.598671830667;5375.247465354853;5171.870703232449;5288.0745869472885;5308.654937429054;5327.946720532784;5361.892762144755;5161.458046905096;5217.921731174036;5225.581953443715;5264.473552644743;5284.709340986245;5210.921836172461;5226.608004399685;5238.580913526908;5248.317718696583;5271.499207575274;5744.994625940443;5767.5962682612235;5780.1907732917425;5802.216700745387;5851.180834683148;6137.438273608336;6162.198914141178;6184.783532576384;6194.132821405007;6278.497720182374;6231.034189700558;6310.684465776692;6323.620582765003;6323.7786677466065;6323.9051414228825;5830.4169583041785;5862.501687356623;5863.589548731547;5864.912026319608;5897.970510147507;6198.318184999646;6243.406876346739;6254.906176407358;6304.621722696653;6312.0531920211415;6178.289496707936;6179.783707570214;6232;6237.719302631302;6243.875122497525;6165.907511387333;6310.7791227306825;6313.40022697843;6317.4946004319545;6317.96841015792;6134.467201660938;6182.845428864224;6187;6205.410486003822;6269.435750782452;6308;6310.652914089677;6311.652859092702;6328.6835658216905;6342.112104305401;4979.3526841510375;4985.850424487271;5048.3184770056305;5050.4949505049935;5054.949450505448;4399.934000989988;4429.247028005247;4436.179306828247;4445.755483448376;4498.887527811766;5816.389279125716;5841.357450680422;5855.882882342329;5894.823155305262;5900.967330717107;5241.659292145999;6275.309715931244;6288.622682639057;6302.180716506825;6336.20797400325;5671.688057156814;5772.9711351442975;5797.304323481209;5832.679202643895;5842.941570584325;5437.401885792559;5437.45625437461;5438.293021907127;5457.935702538047;5492;6367.235931688227;6381.234251889803;6389.744410223632;6391.328910464427;6402.6158430494315;6154.353792851865;6292;6294.8111556653375;6295.338989406229;6305.085762564311;6237.5009999200865;6287.591306565058;6355.046742988588;6363.427291543783;6363.936360636334;6118.862843290023;6121.418465245794;6139.26328840542;6143.1706719592285;6148.631082135086;6235.314115447207;6246.46905013079;6250.1874756281395;6263.342349053284;6274.905876411949;6028.09578563219;6051.1830902829315;6068.150458935665;6131.938680613137;6133.53998450127;6122.051082082285;6123.14276001369;6140.662263575547;6143.385661433821;6186.752529898934;5933.228680271537;6085.344337789054;6090.695465226632;6101.755929762938;6136.907946380718;5970.880582388415;6117.96941015292;6152.169457123231;6162.07568864656;6203.844903877439;6085.330613632408;6105.877882442415;6113.663748493876;6117.724702388314;6122.6938653068055 03:15:05 INFO - PROCESS | 7109 | |1;ext.html;434.93910852480656;456.42262537889565;472.4543152658676;509.8604618677258;519.3897170824281;30655.38689226214;31165.68834311659;32684.836575817117;34214.80248191314;42185.789071054605;40334.19331613374;42930.7853460733;42993.35509967353;43148.784256078674;43186.35220471695;9149.405288656233;9371.25029997602;9372.578233979488;9377.624895004192;9387.43675379476;8406.201410865959;8618.827623447527;9223.354365194438;11108.61119860805;11244.100471962265;11294.830577541303;11340.092792576574;11347.262427942158;11353.148513861493;11386.658400248005;11284.661460156209;11333.829992550118;11362.94318528402;11364.772704545945;11389.82915256276;8331;8555.10171431997;10901.12790976728;11142.777144457146;11197.944010279978;39998.60001399978;40093.79953100245;40691.96540173009;40705.59294407048;41096.1780764383;3634.491171236029;3791.696664266852;4060.451839001756;4077.041895154636;4092.202020605983;30367;30436.54345184824;30572.69427305721;31096.844515777502;31511.84244078765;3165.240342317827;3188.8883889063773;3200.4079245339685;3234.8706051758136;3300.85146168423;393331;466493.66753166355;466570;468118;468230;61197.69401153055;61354.69322653447;61407;61423.6928815362;61478.69260653668;64562.677186613764;64733;64851.67574162099;64892;64935;15825.52523424299;16121.355145794038;16121.516354509384;16179.595510112342;16182.919085404734;11145.665630031112;12305.753884922431;12329.630111096682;12425.254484730945;12448.564300249447;14532.782008269884;14968.251587420586;16697.666046678998;16895.577610559587;17105.401310954057;7412.777616671508;7602.847943041219;7606.429517786078;7650.540967541965;7664.4634875559295;870.0864092702637;877.8814859993947;889.9199072083414;902.9503377314179;913.6665117232295;28410.85794571014;29530.409391812045;30132;30259.848700756356;30607.387852243275;962.7243901830103;975.5073687787622;1020.9387436753818;1024.7182024943052;1066.3495267886583;14266.785998210034;14351;14409.279536023158;14420.711585768435;14554.490592829201;616739;618396;621117;622007;622146;52041;52072.47927520752;52186.478135218924;52234;52325.7383713079;1429.328215738601;1436.755751522223;1452.7893455449112;1457.4607395263608;1463;22335.77664223402;25285.747142529075;27102.593461097706;27337.31656708598;27381.589276160474;46396.7680161597;46639.53360466352;46700.53299466962;46725.53274467212;46784.53215467802;504617.29222184356;523213;523698.10415167455;526333;527423;24122.87938560296;24322;24419.14532991337;24888;25852.35369115787;35914.820425897706;36300.09249768777;41681.37477937894;43944.34083488686;44546;35287.470687940215;35309.64690353166;35551;36625.63374366222;36789.033480480866;35261.471077934366;35357.646423535436;36220.456693150154;36237.456438153975;36511.45232821563;34823.65176348204;34964.47553286652;35436.46845297374;35562.93311200668;35898.28203435969;22256.666150008088;30314.090577282717;31033.844830775703;31757.20606984844;31850.840745796122;16514.504564863073;18922.905385472983;21341.14635414566;23414.03004154685;23504.177353792536 03:15:05 INFO - PROCESS | 7109 | |2;jquery.html;391.22342150830616;395.7328803057935;396.3183324681548;401.72481849932797;421.2775090719417;14354;16963.660726785456;19854.70217946732;21085.789142108595;21183.576328473442;16096;17904.28382864684;19894.801051989474;20570.588588228227;20689.793102068976;5724.398938111491;6051.667158306292;6061.242344706911;6067.484263837579;6070.028795392738;5774.595778295521;5884;5994.820155395323;6005.459508644221;6035.094735789645;5964.731587078571;6160.691965401712;6164.568480206387;6184.5052395808225;6201.565890387675;4959.677620954644;6051.576389652726;6087.54343424245;6104.236970378703;6129.1419201311855;5804.071348584249;5913.881722365529;5915.763369465216;5921.259842519685;5931.317898441691;22099.895005249833;23564.64653030206;24654.50690986188;24713.50572988548;24915;2796.6224559684388;2871.2821794551364;2883.5098033334384;2888.79778415511;2892.1612732307603;9822.852657210147;9853.20551228279;9896.158826499755;10333.58665653373;10444.42555659446;1811.7191835265555;1859.739636450898;1861.3485280151974;1869.401791426744;1872.1481725814722;101209.87901209894;106862;139383.30308348493;139961;142117;11320.26418282809;11523.942380288212;11585.594504192313;11650.563083890273;11874.525018999144;15195.468158614396;15218.46735364279;15234.847651523565;15247.161406122548;15255.389784408499;7461.515001524992;7649.923500764921;7779.611019449005;7810.531368117931;7918.089419716691;6993.335633114948;7437.479376443597;8105.716299929474;8211.630476628567;8213.646767213386;4586.403767510203;4621.329907163443;4623.445186577632;4638.628909687217;4709.1994360958715;1709.239388472118;1990.243707391211;2019.7677267114177;2028.1177687705895;2028.3103744726864;997.5012493753123;1000.4997501249376;1002.4286156890648;1006.3458751811381;1053.2942928238099;19314.13086411115;20460;20915.163393464394;21090.47273818136;21148.165888316867;1013.7719013222113;1023.150784848574;1055.904968552834;1058.5554067291755;1060.151878497199;9384.765380865396;11001.119910407147;11001.449927503592;11024.393658348707;11074.446277686244;712041;717765.4111729407;728277;732066;734874;135486;139153;149861;150017;157354;1009.8838633557089;1049.7900419916048;1055.350959160111;1070.9999999999843;1071.4321409652896;18195.363162289257;18835;18872.433826985212;18894.622107557498;18914.52713682114;41135;46087;51401.7429912848;52027.21959170691;56896.715516422155;78303.60848195723;78793.60603196947;83986;84719;86924.56537717271;6956.686949087202;7954.284114429498;7994.360451163777;8290.958545207235;11897.583584574499;12543.435545400296;12549.74900502003;13063;13173.670658233237;13414;10588.258821882395;10715.142788577052;11071.889281107085;11084.556617735201;11597.014253788522;11350.716232094264;11354.489047993025;11550.422478875855;11596.840315968335;11893.405329733652;10195.184385249015;10336.227277043674;11066.114710822954;11375.601853935073;11474.196806223817;12232.204906681038;12463.314517701614;12465.252084874937;12666.303353315656;12669.873301266869;10924.50839712199;11080.168987326144;11200.271982321123;11333.619939812403;11754.823677645014 03:15:05 INFO - PROCESS | 7109 | |3;mootools.html;1340.8726171013752;1458.8395276519589;1467.4130347860855;1492.0972811449074;1500.2123884960395;8030.91969080309;8473.983122025365;8481.067082620923;8495.660173593064;8496.32029437645;7349.522281051742;7628.466007379472;7645.311921927026;7804.92195078049;8036.598170091486;2248.291788086756;2280.213326402397;2285.6228722260807;2287.553926984239;2288.6338185890263;2010.808973147556;2277.578647950126;2313.9421514462188;2345.5074434368803;2348.0842471436154;2033.7695694105;2203.151786562177;2223.613222450741;2243.3270018994317;2294.9311520654323;2134.722486076808;2306.5156317173246;2306.8269879759087;2310.4108452344713;2312.6877871487386;2219.212179676224;2333.8132949364012;2334.8365614407;2340.719113706349;2348.38941875112;8365.07984121746;8435.029971553227;8440.62017209227;8451;8455.619497122645;5070.492950704936;5154.226865970135;5177.016366890279;5179.61152913533;5196.194589838581;3320.6181289151814;3343.983280083584;3406.1654894550993;3517.9824100879587;3522.7181825453904;1176.6352430746497;1180.6989217749506;1215.775081609905;1233.9208433789095;1233.969150771229;10655.733606659818;10782;10785.784284314348;10786;10790.73023174419;3925.509311336083;4372.3878656988045;4605.746683932416;4690.437147542249;4696.365990591226;8732.083131271253;9332.72001839946;9333.859992100124;9336.253099752004;9343.299252556086;5208.166693329125;5226.059309324358;5233.188855727369;5234.42421333653;5241.135212689864;4679.274712419512;4749.691270067435;4793.664443488922;4850.854474365775;4884.755762211875;3178.761592880543;3782.432635104756;3843.7501562398356;3887.1253967857006;3906.1015966327905;1280.7246442015012;1284.5825106840314;1286.1961274203622;1297.202220634303;1304.4130141436392;712.5938215217276;757.2541047068632;787.145946647882;788.5347644889542;811.5617566514017;4239.8092085856215;4417.712848664826;5333.200019997032;5415.296011518478;5605.383407825218;564.7035306464139;577.376433451871;578.1847594891183;579.1168468086203;583.1224007868132;3560.483729859208;3586.7847929124337;3641.6358364163902;3642.3261696586214;3705.6479634434686;9504.239660827117;9902.257330700082;9911;9913.851292230622;9925.751856203653;9769.853452198222;9866;9937.602495900082;9952.203823694088;9960.352577082467;7599.924000760032;7665.846683066307;7730.806729831799;7808.219178082147;7822.647980840876;5234.869128271824;5328.440513746001;5348.57211423093;5411.594130440154;5577.8047768327915;8236.917630823615;8844.823103537765;9015;9137.725868223964;9145.268378529834;7787.338076263581;8970.282377409922;9050.230730387992;9404.059594040815;9452.905470945203;5860.648361098348;7006.544574602634;7095.006699062033;7096.467764917755;7100.964495177491;7609.162992070978;7654.846903062019;7756.728514501965;7757.418193635387;7768;6929.099217101744;7006.754763583454;7010.053642758162;7028.402585780062;7031;6833.214180369122;6950.096487456598;6952.409045231212;6960.23437421873;7009.754658586925;6111.419415155553;6268.749250029948;6295.3704629538515;6308.684565771785;6317.399847014526;4096.242195193899;4770.522947705202;4789.95210047909;5011.248312753116;5044.192929131322;4735.479097299363;4815.831445899376;4817.27740838877;4878.80484780619;4884.316195732529 03:15:05 INFO - PROCESS | 7109 | |4;prototype.html;328.3269297939227;330.7250549133092;337.701134495971;351.7537723593485;374.7320665724007;4621.6533759968015;4737.886596649789;5352.501299636103;5399.649022813514;5491.890162196753;4182.059036716737;4372.366006928994;4399.690162664603;5266.894662106755;5313.362396512424;3441.434147462911;3868.6905047596197;3888.4556162137324;4042.4542686737354;4082.122343696105;3855.9421608675893;3965.2267807777494;3978.9204215915665;4081.653059489947;4093.22228776533;3406.8807591734294;3887.650111489965;4051.3517837146064;4071.979640101795;4076.2458945095104;4003.7597744135446;4038.1020920167475;4049.5950404959267;4056.837726490937;4075.918481630351;3344.8494817733263;3444.896653100411;3502.073859377332;3502.3889011054944;3549.680528752399;4625.606823420013;5152.9742351288005;5207.921881171786;5215.869603259911;5250.894982100374;4590.701604395737;4597.655215821051;4601.654875884322;4603.884902877421;4604.562566556172;5303.469653034705;5324.094903866352;5557.888842223133;5650.880919655129;5699.487046165824;3255.1335753049107;3789.2758794748324;3799.2591444668024;3820.7134464915243;3822.0635944193573;5447.945520544784;5510.421405752419;5616.9608622404985;5893.381194974509;5905.763769449174;3392.456432323287;3764.6235376462137;3798.0315019669806;3905.5508616508896;3910.335243008695;3266.4283750343593;3282.786618869766;3907.433422153772;3927.546807681119;3947.684185265172;4077.8989672788775;4278.422412974271;4319.028218650778;4456.866294011184;4574.977125114353;4703.553162449562;4741.881452963704;5602.663840169603;5639.798350229105;5648.15277708347;1245.6698974771693;1265.3609926986996;1268.733565951142;1281;1282.0320657903223;811.5414790643267;828.8300898315831;843.9367047471465;866.2982983783156;876.5748611923212;4690.833687261085;4928.623892633557;5020.7406667;5039.21892106724;5060.51925067118;4619.3994780678295;4779.737114458738;5176.689398636094;5470.781168753205;5567.46894603979;4604.033153037833;4755.643326750507;4841.538300115434;4862.975685121552;5050.6464547482055;2374.6016523311578;2607.191770551135;2869.43615729428;2876.2234196767176;2881.6109825173753;4873.951260487421;4964.44331169448;5614.466625670555;5620.611240222889;5659;4698.906021879611;5185.585153187736;5496.587755918242;5510.752016159283;5623.746931388016;4801.18379875422;5291.100512912814;5411.729413529387;5600.131979543095;5656.918812276736;4442.600165985077;5232.869178270574;5401.783928642811;5459.918101228564;5475.123980163155;4472.2942619715905;4686.671932964659;5255.3168088148295;5308.654937429054;5366.007288651612;4671.649626277975;4843.418789745253;5433.8369848904595;5606.831795046155;5631.802886898939;3158.463061279542;3627.673509384168;3635.2547727716283;3644.6173151818675;3658.35374081659;5020.899582008266;5186.8962620746615;5423.647462914898;5465.212741501783;5500.4224556420995;4698.8355407560575;5014.9498505015945;5563.471470210324;5644.548436125018;5707.229524014205;4517.679505563343;4754.5245475452175;5223;5562.3047119110115;5590.776368945197;4543.65922555803;5489.682476205761;5503.807366742145;5521.889562208814;5591.636543624814;5386.865328366822;5394.163904594794;5542.7782888685615;5578.3584887738425;5608.831735047955;5250.921236181384;5281.9471805281455;5534.339698090476;5541.362743284574;5568.777248909998 03:15:05 INFO - PROCESS | 7109 | |5;yui.html;712.9037579926709;728.3117454005964;754.5548126605302;817.5544328341053;841.4740787008121;14860.33128509217;15043.774343384857;15521.456749013787;15568.688626227497;15603;11409.030232430232;14003.719925601481;14054.086484378508;14087.154770713738;14089;741.4587351233603;859.4456575508777;877.5787621941472;878.1789027259501;878.1832895407268;674.7469698862926;695.4818660098208;700.5726506830829;873.0614589316478;873.4453621950043;883.9911600884005;888.506878682331;917.0142097245455;923.0169869089399;926.3284119013729;882.0429833630518;905.8586181411404;906.2613969614742;906.8231694819513;907.0883761819396;514.7194778845538;530.822174571519;674.7638326585704;674.8582797612507;677.8169894128607;11986.634902084113;12047.698807529794;12374.195677280948;12396.442160102726;15115.848841511664;14016.509422170277;14325.426982920671;14438;14456.27718614065;14804.037737547025;11718.945294923413;11720.413979301002;11889.702757431047;11974.401279935968;11990.100742444352;3496.30073985204;3654.6710796028483;3672.2288319452946;3774.2074164425503;3798.2593394288124;99982;103162;103484.48257758738;104371.95628043698;105556;10591.57633694659;10631.681049568526;10635.94682026585;10862.511186996604;10892;20464.181432742524;20475.79524204739;20814.895925520275;20842.89578552128;20845.478863028544;7426.108866936002;7433.516821406592;7460.403167746567;7497.737579184703;7569.810754731066;4261.786910654455;4268.914621707549;4316;4318.870433886988;4333.934990975138;3543.7165026797793;3587.7847329160336;3649.635036496329;3655.7806531607657;3660.5058317127377;634.3624657219465;640.5868215001298;642.495640921874;654.5450911616476;658.716751796732;583.4194975998909;659.8548319369731;694.9548279361825;703.8521910398771;716.3266529462393;9223.76940576491;9715;9918.454485003394;9954.710461533934;9956.854961679355;666.8532922756985;691.6507163882208;691.7993781803322;710.559453139057;715.427657873699;4015.8996025099605;4770.284457331359;4817.662763606584;4836.322914791932;4938.578975934536;90388.5480572593;95289.52355238318;96973.5453968191;97289;99331.50334248427;82934.58532707297;84238.15761842304;84241;84922.5753871239;86165;68949.31050689428;69462;69498.30501694918;70264.64867675527;71046.64476677687;9215.67745128944;9234.584443699916;9240.861387079334;9282.21101206405;9286.210672092677;43566.782166090234;45415.77292113518;50347.13371020749;50467.49532504775;50978.74510627423;65959;66762.33237667561;67440.6627966857;68105.97841032488;69036.6548167256;9555.61777528891;11185.608503702331;11596;11645;11719.238249513754;12222.20555663879;12323.75352492963;12402.25586464815;12678.366081696062;13044.608661740163;9884.333326708702;11838.348890811088;12046.337451440255;12134.271943683407;12135.635930921733;8249.711260105867;10084.546195421077;10224.437655928996;10523.842142367717;10614.363138211733;10626.787464250827;11015.490533562772;11516.021138203347;11700.70748231301;11754.23597466162;9262.39794413361;9742.75643108928;9866.753331166492;10150.23873209527;10168.644097456554;8955.283338312865;9455.338126331091;9494.715158545254;9670.419774813534;9714 03:15:05 INFO - PROCESS | 7109 | __end_tp_report 03:15:05 INFO - PROCESS | 7109 | __start_cc_report 03:15:05 INFO - PROCESS | 7109 | _x_x_mozilla_cycle_collect,1093 03:15:05 INFO - PROCESS | 7109 | __end_cc_report 03:15:05 INFO - PROCESS | 7109 | __startTimestamp1484306105616__endTimestamp 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | ------- Summary: start ------- 03:15:05 INFO - PROCESS | 7109 | Number of tests: 6 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | [#0] dojo.html Cycles:165 Average:5789.63 Median:6085.34 stddev:645.06 (10.6%) stddev-sans-first:615.59 03:15:05 INFO - PROCESS | 7109 | Values: 3253.6 3294.8 3311.6 3320.9 3357.5 5601.4 5683.6 5716.2 5722.7 5741.9 5697.7 5721.1 5807.9 5813.9 5842.5 5149.7 5177.3 5196.1 5253.3 5302.2 5313.6 5326.8 5327.1 5330.6 5375.2 5171.9 5288.1 5308.7 5327.9 5361.9 5161.5 5217.9 5225.6 5264.5 5284.7 5210.9 5226.6 5238.6 5248.3 5271.5 5745.0 5767.6 5780.2 5802.2 5851.2 6137.4 6162.2 6184.8 6194.1 6278.5 6231.0 6310.7 6323.6 6323.8 6323.9 5830.4 5862.5 5863.6 5864.9 5898.0 6198.3 6243.4 6254.9 6304.6 6312.1 6178.3 6179.8 6232.0 6237.7 6243.9 6165.9 6310.8 6313.4 6317.5 6318.0 6134.5 6182.8 6187.0 6205.4 6269.4 6308.0 6310.7 6311.7 6328.7 6342.1 4979.4 4985.9 5048.3 5050.5 5054.9 4399.9 4429.2 4436.2 4445.8 4498.9 5816.4 5841.4 5855.9 5894.8 5901.0 5241.7 6275.3 6288.6 6302.2 6336.2 5671.7 5773.0 5797.3 5832.7 5842.9 5437.4 5437.5 5438.3 5457.9 5492.0 6367.2 6381.2 6389.7 6391.3 6402.6 6154.4 6292.0 6294.8 6295.3 6305.1 6237.5 6287.6 6355.0 6363.4 6363.9 6118.9 6121.4 6139.3 6143.2 6148.6 6235.3 6246.5 6250.2 6263.3 6274.9 6028.1 6051.2 6068.2 6131.9 6133.5 6122.1 6123.1 6140.7 6143.4 6186.8 5933.2 6085.3 6090.7 6101.8 6136.9 5970.9 6118.0 6152.2 6162.1 6203.8 6085.3 6105.9 6113.7 6117.7 6122.7 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | [#1] ext.html Cycles:180 Average:65941.78 Median:35730.61 stddev:143201.27 (400.8%) stddev-sans-first:143518.52 03:15:05 INFO - PROCESS | 7109 | Values: 434.9 456.4 472.5 509.9 519.4 30655.4 31165.7 32684.8 34214.8 42185.8 40334.2 42930.8 42993.4 43148.8 43186.4 9149.4 9371.3 9372.6 9377.6 9387.4 8406.2 8618.8 9223.4 11108.6 11244.1 11294.8 11340.1 11347.3 11353.1 11386.7 11284.7 11333.8 11362.9 11364.8 11389.8 8331.0 8555.1 10901.1 11142.8 11197.9 39998.6 40093.8 40692.0 40705.6 41096.2 3634.5 3791.7 4060.5 4077.0 4092.2 30367.0 30436.5 30572.7 31096.8 31511.8 3165.2 3188.9 3200.4 3234.9 3300.9 393331.0 466493.7 466570.0 468118.0 468230.0 61197.7 61354.7 61407.0 61423.7 61478.7 64562.7 64733.0 64851.7 64892.0 64935.0 15825.5 16121.4 16121.5 16179.6 16182.9 11145.7 12305.8 12329.6 12425.3 12448.6 14532.8 14968.3 16697.7 16895.6 17105.4 7412.8 7602.8 7606.4 7650.5 7664.5 870.1 877.9 889.9 903.0 913.7 28410.9 29530.4 30132.0 30259.8 30607.4 962.7 975.5 1020.9 1024.7 1066.3 14266.8 14351.0 14409.3 14420.7 14554.5 616739.0 618396.0 621117.0 622007.0 622146.0 52041.0 52072.5 52186.5 52234.0 52325.7 1429.3 1436.8 1452.8 1457.5 1463.0 22335.8 25285.7 27102.6 27337.3 27381.6 46396.8 46639.5 46700.5 46725.5 46784.5 504617.3 523213.0 523698.1 526333.0 527423.0 24122.9 24322.0 24419.1 24888.0 25852.4 35914.8 36300.1 41681.4 43944.3 44546.0 35287.5 35309.6 35551.0 36625.6 36789.0 35261.5 35357.6 36220.5 36237.5 36511.5 34823.7 34964.5 35436.5 35562.9 35898.3 22256.7 30314.1 31033.8 31757.2 31850.8 16514.5 18922.9 21341.1 23414.0 23504.2 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | [#2] jquery.html Cycles:180 Average:39358.61 Median:2023.94 stddev:120613.81 (5959.3%) stddev-sans-first:120916.67 03:15:05 INFO - PROCESS | 7109 | Values: 391.2 395.7 396.3 401.7 421.3 14354.0 16963.7 19854.7 21085.8 21183.6 16096.0 17904.3 19894.8 20570.6 20689.8 5724.4 6051.7 6061.2 6067.5 6070.0 5774.6 5884.0 5994.8 6005.5 6035.1 5964.7 6160.7 6164.6 6184.5 6201.6 4959.7 6051.6 6087.5 6104.2 6129.1 5804.1 5913.9 5915.8 5921.3 5931.3 22099.9 23564.6 24654.5 24713.5 24915.0 2796.6 2871.3 2883.5 2888.8 2892.2 9822.9 9853.2 9896.2 10333.6 10444.4 1811.7 1859.7 1861.3 1869.4 1872.1 101209.9 106862.0 139383.3 139961.0 142117.0 11320.3 11523.9 11585.6 11650.6 11874.5 15195.5 15218.5 15234.8 15247.2 15255.4 7461.5 7649.9 7779.6 7810.5 7918.1 6993.3 7437.5 8105.7 8211.6 8213.6 4586.4 4621.3 4623.4 4638.6 4709.2 1709.2 1990.2 2019.8 2028.1 2028.3 997.5 1000.5 1002.4 1006.3 1053.3 19314.1 20460.0 20915.2 21090.5 21148.2 1013.8 1023.2 1055.9 1058.6 1060.2 9384.8 11001.1 11001.4 11024.4 11074.4 712041.0 717765.4 728277.0 732066.0 734874.0 135486.0 139153.0 149861.0 150017.0 157354.0 1009.9 1049.8 1055.4 1071.0 1071.4 18195.4 18835.0 18872.4 18894.6 18914.5 41135.0 46087.0 51401.7 52027.2 56896.7 78303.6 78793.6 83986.0 84719.0 86924.6 6956.7 7954.3 7994.4 8291.0 11897.6 12543.4 12549.7 13063.0 13173.7 13414.0 10588.3 10715.1 11071.9 11084.6 11597.0 11350.7 11354.5 11550.4 11596.8 11893.4 10195.2 10336.2 11066.1 11375.6 11474.2 12232.2 12463.3 12465.3 12666.3 12669.9 10924.5 11080.2 11200.3 11333.6 11754.8 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | [#3] mootools.html Cycles:180 Average:5318.89 Median:5234.65 stddev:2928.14 (55.9%) stddev-sans-first:2921.09 03:15:05 INFO - PROCESS | 7109 | Values: 1340.9 1458.8 1467.4 1492.1 1500.2 8030.9 8474.0 8481.1 8495.7 8496.3 7349.5 7628.5 7645.3 7804.9 8036.6 2248.3 2280.2 2285.6 2287.6 2288.6 2010.8 2277.6 2313.9 2345.5 2348.1 2033.8 2203.2 2223.6 2243.3 2294.9 2134.7 2306.5 2306.8 2310.4 2312.7 2219.2 2333.8 2334.8 2340.7 2348.4 8365.1 8435.0 8440.6 8451.0 8455.6 5070.5 5154.2 5177.0 5179.6 5196.2 3320.6 3344.0 3406.2 3518.0 3522.7 1176.6 1180.7 1215.8 1233.9 1234.0 10655.7 10782.0 10785.8 10786.0 10790.7 3925.5 4372.4 4605.7 4690.4 4696.4 8732.1 9332.7 9333.9 9336.3 9343.3 5208.2 5226.1 5233.2 5234.4 5241.1 4679.3 4749.7 4793.7 4850.9 4884.8 3178.8 3782.4 3843.8 3887.1 3906.1 1280.7 1284.6 1286.2 1297.2 1304.4 712.6 757.3 787.1 788.5 811.6 4239.8 4417.7 5333.2 5415.3 5605.4 564.7 577.4 578.2 579.1 583.1 3560.5 3586.8 3641.6 3642.3 3705.6 9504.2 9902.3 9911.0 9913.9 9925.8 9769.9 9866.0 9937.6 9952.2 9960.4 7599.9 7665.8 7730.8 7808.2 7822.6 5234.9 5328.4 5348.6 5411.6 5577.8 8236.9 8844.8 9015.0 9137.7 9145.3 7787.3 8970.3 9050.2 9404.1 9452.9 5860.6 7006.5 7095.0 7096.5 7101.0 7609.2 7654.8 7756.7 7757.4 7768.0 6929.1 7006.8 7010.1 7028.4 7031.0 6833.2 6950.1 6952.4 6960.2 7009.8 6111.4 6268.7 6295.4 6308.7 6317.4 4096.2 4770.5 4790.0 5011.2 5044.2 4735.5 4815.8 4817.3 4878.8 4884.3 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | [#4] prototype.html Cycles:180 Average:4383.89 Median:4767.69 stddev:1333.53 (28.0%) stddev-sans-first:1302.06 03:15:05 INFO - PROCESS | 7109 | Values: 328.3 330.7 337.7 351.8 374.7 4621.7 4737.9 5352.5 5399.6 5491.9 4182.1 4372.4 4399.7 5266.9 5313.4 3441.4 3868.7 3888.5 4042.5 4082.1 3855.9 3965.2 3978.9 4081.7 4093.2 3406.9 3887.7 4051.4 4072.0 4076.2 4003.8 4038.1 4049.6 4056.8 4075.9 3344.8 3444.9 3502.1 3502.4 3549.7 4625.6 5153.0 5207.9 5215.9 5250.9 4590.7 4597.7 4601.7 4603.9 4604.6 5303.5 5324.1 5557.9 5650.9 5699.5 3255.1 3789.3 3799.3 3820.7 3822.1 5447.9 5510.4 5617.0 5893.4 5905.8 3392.5 3764.6 3798.0 3905.6 3910.3 3266.4 3282.8 3907.4 3927.5 3947.7 4077.9 4278.4 4319.0 4456.9 4575.0 4703.6 4741.9 5602.7 5639.8 5648.2 1245.7 1265.4 1268.7 1281.0 1282.0 811.5 828.8 843.9 866.3 876.6 4690.8 4928.6 5020.7 5039.2 5060.5 4619.4 4779.7 5176.7 5470.8 5567.5 4604.0 4755.6 4841.5 4863.0 5050.6 2374.6 2607.2 2869.4 2876.2 2881.6 4874.0 4964.4 5614.5 5620.6 5659.0 4698.9 5185.6 5496.6 5510.8 5623.7 4801.2 5291.1 5411.7 5600.1 5656.9 4442.6 5232.9 5401.8 5459.9 5475.1 4472.3 4686.7 5255.3 5308.7 5366.0 4671.6 4843.4 5433.8 5606.8 5631.8 3158.5 3627.7 3635.3 3644.6 3658.4 5020.9 5186.9 5423.6 5465.2 5500.4 4698.8 5014.9 5563.5 5644.5 5707.2 4517.7 4754.5 5223.0 5562.3 5590.8 4543.7 5489.7 5503.8 5521.9 5591.6 5386.9 5394.2 5542.8 5578.4 5608.8 5250.9 5281.9 5534.3 5541.4 5568.8 03:15:05 INFO - PROCESS | 7109 | 03:15:05 INFO - PROCESS | 7109 | [#5] yui.html Cycles:180 Average:19273.69 Median:608.89 stddev:27975.10 (4594.4%) stddev-sans-first:28018.87 03:15:05 INFO - PROCESS | 7109 | Values: 712.9 728.3 754.6 817.6 841.5 14860.3 15043.8 15521.5 15568.7 15603.0 11409.0 14003.7 14054.1 14087.2 14089.0 741.5 859.4 877.6 878.2 878.2 674.7 695.5 700.6 873.1 873.4 884.0 888.5 917.0 923.0 926.3 882.0 905.9 906.3 906.8 907.1 514.7 530.8 674.8 674.9 677.8 11986.6 12047.7 12374.2 12396.4 15115.8 14016.5 14325.4 14438.0 14456.3 14804.0 11718.9 11720.4 11889.7 11974.4 11990.1 3496.3 3654.7 3672.2 3774.2 3798.3 99982.0 103162.0 103484.5 104372.0 105556.0 10591.6 10631.7 10635.9 10862.5 10892.0 20464.2 20475.8 20814.9 20842.9 20845.5 7426.1 7433.5 7460.4 7497.7 7569.8 4261.8 4268.9 4316.0 4318.9 4333.9 3543.7 3587.8 3649.6 3655.8 3660.5 634.4 640.6 642.5 654.5 658.7 583.4 659.9 695.0 703.9 716.3 9223.8 9715.0 9918.5 9954.7 9956.9 666.9 691.7 691.8 710.6 715.4 4015.9 4770.3 4817.7 4836.3 4938.6 90388.5 95289.5 96973.5 97289.0 99331.5 82934.6 84238.2 84241.0 84922.6 86165.0 68949.3 69462.0 69498.3 70264.6 71046.6 9215.7 9234.6 9240.9 9282.2 9286.2 43566.8 45415.8 50347.1 50467.5 50978.7 65959.0 66762.3 67440.7 68106.0 69036.7 9555.6 11185.6 11596.0 11645.0 11719.2 12222.2 12323.8 12402.3 12678.4 13044.6 9884.3 11838.3 12046.3 12134.3 12135.6 8249.7 10084.5 10224.4 10523.8 10614.4 10626.8 11015.5 11516.0 11700.7 11754.2 9262.4 9742.8 9866.8 10150.2 10168.6 8955.3 9455.3 9494.7 9670.4 9714.0 03:15:05 INFO - PROCESS | 7109 | -------- Summary: end -------- 03:15:05 INFO - PROCESS | 7109 | 03:15:06 INFO - TEST-INFO | 7109: exit 0 03:15:06 INFO - TEST-OK | dromaeo_css | took 1118613ms 03:15:06 INFO - TEST-START | kraken 03:15:06 INFO - operating with platform_type : mac_ 03:15:06 INFO - Initialising browser for kraken test... 03:15:06 INFO - TEST-INFO | started process 7115 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpsBt3aV/profile http://localhost:49770/getInfo.html) 03:15:08 INFO - PROCESS | 7115 | __metrics Screen width/height:1600/1200 03:15:08 INFO - PROCESS | 7115 | colorDepth:24 03:15:08 INFO - PROCESS | 7115 | Browser inner width/height: 1024/689 03:15:08 INFO - PROCESS | 7115 | __metrics 03:15:08 INFO - PROCESS | 7115 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:15:08 INFO - PROCESS | 7115 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:15:09 INFO - TEST-INFO | 7115: exit 0 03:15:09 INFO - Browser initialized. 03:15:09 INFO - Running cycle 1/1 for kraken test... 03:15:09 INFO - TEST-INFO | started process 7116 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpsBt3aV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:21 INFO - PROCESS | 7116 | RSS: Main: 235048960 03:15:21 INFO - PROCESS | 7116 | 03:15:24 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49770/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:25 INFO - PROCESS | 7116 | RSS: Main: 286674944 03:15:25 INFO - PROCESS | 7116 | 03:15:28 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49770/tests/kraken/driver.html?testName=audio-dft) 03:15:28 INFO - PROCESS | 7116 | RSS: Main: 286289920 03:15:28 INFO - PROCESS | 7116 | 03:15:32 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49770/tests/kraken/driver.html?testName=audio-fft) 03:15:32 INFO - PROCESS | 7116 | RSS: Main: 379293696 03:15:32 INFO - PROCESS | 7116 | 03:15:34 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49770/tests/kraken/driver.html?testName=audio-oscillator) 03:15:35 INFO - PROCESS | 7116 | RSS: Main: 282222592 03:15:35 INFO - PROCESS | 7116 | 03:15:37 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:38 INFO - PROCESS | 7116 | RSS: Main: 286154752 03:15:38 INFO - PROCESS | 7116 | 03:15:40 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49770/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:41 INFO - PROCESS | 7116 | RSS: Main: 327442432 03:15:41 INFO - PROCESS | 7116 | 03:15:44 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49770/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:45 INFO - PROCESS | 7116 | RSS: Main: 329940992 03:15:45 INFO - PROCESS | 7116 | 03:15:48 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49770/tests/kraken/driver.html?testName=json-parse-financial) 03:15:48 INFO - PROCESS | 7116 | RSS: Main: 328790016 03:15:48 INFO - PROCESS | 7116 | 03:15:50 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:50 INFO - PROCESS | 7116 | RSS: Main: 303632384 03:15:50 INFO - PROCESS | 7116 | 03:15:53 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:53 INFO - PROCESS | 7116 | RSS: Main: 304988160 03:15:53 INFO - PROCESS | 7116 | 03:15:55 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:56 INFO - PROCESS | 7116 | RSS: Main: 310050816 03:15:56 INFO - PROCESS | 7116 | 03:15:59 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:00 INFO - PROCESS | 7116 | RSS: Main: 326377472 03:16:00 INFO - PROCESS | 7116 | 03:16:03 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:03 INFO - PROCESS | 7116 | RSS: Main: 320286720 03:16:03 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:49770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49770/tests/kraken/driver.html?testName=ai-astar) 03:16:05 INFO - PROCESS | 7116 | RSS: Main: 363843584 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | __start_tp_report 03:16:05 INFO - PROCESS | 7116 | _x_x_mozilla_page_load 03:16:05 INFO - PROCESS | 7116 | _x_x_mozilla_page_load_details 03:16:05 INFO - PROCESS | 7116 | |i|pagename|runs| 03:16:05 INFO - PROCESS | 7116 | |0;ai-astar;114;113;114;111;114;113;113;113;113;113 03:16:05 INFO - PROCESS | 7116 | |1;audio-beat-detection;147;124;138;147;114;139;138;108;131;112 03:16:05 INFO - PROCESS | 7116 | |2;audio-dft;184;186;189;185;185;183;182;170;231;258 03:16:05 INFO - PROCESS | 7116 | |3;audio-fft;83;58;58;88;60;58;58;58;75;58 03:16:05 INFO - PROCESS | 7116 | |4;audio-oscillator;89;75;86;70;68;70;82;88;99;114 03:16:05 INFO - PROCESS | 7116 | |5;imaging-gaussian-blur;88;87;90;87;88;85;89;87;89;85 03:16:05 INFO - PROCESS | 7116 | |6;imaging-darkroom;94;95;95;113;150;95;95;95;107;128 03:16:05 INFO - PROCESS | 7116 | |7;imaging-desaturate;88;108;132;88;89;88;87;89;88;88 03:16:05 INFO - PROCESS | 7116 | |8;json-parse-financial;56;56;56;56;56;53;54;75;81;84 03:16:05 INFO - PROCESS | 7116 | |9;json-stringify-tinderbox;67;70;81;75;76;71;72;97;105;107 03:16:05 INFO - PROCESS | 7116 | |10;stanford-crypto-aes;91;88;89;87;87;87;90;89;86;85 03:16:05 INFO - PROCESS | 7116 | |11;stanford-crypto-ccm;140;141;144;146;152;137;139;144;201;152 03:16:05 INFO - PROCESS | 7116 | |12;stanford-crypto-pbkdf2;175;174;175;175;175;175;174;173;175;174 03:16:05 INFO - PROCESS | 7116 | |13;stanford-crypto-sha256-iterative;68;70;78;86;88;87;73;67;65;66 03:16:05 INFO - PROCESS | 7116 | __end_tp_report 03:16:05 INFO - PROCESS | 7116 | __start_cc_report 03:16:05 INFO - PROCESS | 7116 | _x_x_mozilla_cycle_collect,1955 03:16:05 INFO - PROCESS | 7116 | __end_cc_report 03:16:05 INFO - PROCESS | 7116 | __startTimestamp1484306165892__endTimestamp 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | ------- Summary: start ------- 03:16:05 INFO - PROCESS | 7116 | Number of tests: 14 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 03:16:05 INFO - PROCESS | 7116 | Values: 114.0 113.0 114.0 111.0 114.0 113.0 113.0 113.0 113.0 113.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:138.00 stddev:14.48 (10.5%) stddev-sans-first:13.96 03:16:05 INFO - PROCESS | 7116 | Values: 147.0 124.0 138.0 147.0 114.0 139.0 138.0 108.0 131.0 112.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#2] audio-dft Cycles:10 Average:195.30 Median:185.50 stddev:27.16 (14.6%) stddev-sans-first:28.50 03:16:05 INFO - PROCESS | 7116 | Values: 184.0 186.0 189.0 185.0 185.0 183.0 182.0 170.0 231.0 258.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#3] audio-fft Cycles:10 Average:65.40 Median:59.00 stddev:11.88 (20.1%) stddev-sans-first:10.76 03:16:05 INFO - PROCESS | 7116 | Values: 83.0 58.0 58.0 88.0 60.0 58.0 58.0 58.0 75.0 58.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:84.00 stddev:14.54 (17.3%) stddev-sans-first:15.31 03:16:05 INFO - PROCESS | 7116 | Values: 89.0 75.0 86.0 70.0 68.0 70.0 82.0 88.0 99.0 114.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.00 stddev:1.65 (1.9%) stddev-sans-first:1.74 03:16:05 INFO - PROCESS | 7116 | Values: 88.0 87.0 90.0 87.0 88.0 85.0 89.0 87.0 89.0 85.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#6] imaging-darkroom Cycles:10 Average:106.70 Median:95.00 stddev:18.90 (19.9%) stddev-sans-first:19.48 03:16:05 INFO - PROCESS | 7116 | Values: 94.0 95.0 95.0 113.0 150.0 95.0 95.0 95.0 107.0 128.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:88.00 stddev:14.59 (16.6%) stddev-sans-first:15.29 03:16:05 INFO - PROCESS | 7116 | Values: 88.0 108.0 132.0 88.0 89.0 88.0 87.0 89.0 88.0 88.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:56.00 stddev:12.18 (21.7%) stddev-sans-first:12.67 03:16:05 INFO - PROCESS | 7116 | Values: 56.0 56.0 56.0 56.0 56.0 53.0 54.0 75.0 81.0 84.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#9] json-stringify-tinderbox Cycles:10 Average:82.10 Median:73.50 stddev:15.11 (20.6%) stddev-sans-first:15.01 03:16:05 INFO - PROCESS | 7116 | Values: 67.0 70.0 81.0 75.0 76.0 71.0 72.0 97.0 105.0 107.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.50 stddev:1.85 (2.1%) stddev-sans-first:1.59 03:16:05 INFO - PROCESS | 7116 | Values: 91.0 88.0 89.0 87.0 87.0 87.0 90.0 89.0 86.0 85.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:145.00 stddev:18.76 (12.9%) stddev-sans-first:19.57 03:16:05 INFO - PROCESS | 7116 | Values: 140.0 141.0 144.0 146.0 152.0 137.0 139.0 144.0 201.0 152.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 03:16:05 INFO - PROCESS | 7116 | Values: 175.0 174.0 175.0 175.0 175.0 175.0 174.0 173.0 175.0 174.0 03:16:05 INFO - PROCESS | 7116 | 03:16:05 INFO - PROCESS | 7116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.50 stddev:9.22 (12.2%) stddev-sans-first:9.45 03:16:05 INFO - PROCESS | 7116 | Values: 68.0 70.0 78.0 86.0 88.0 87.0 73.0 67.0 65.0 66.0 03:16:05 INFO - PROCESS | 7116 | -------- Summary: end -------- 03:16:05 INFO - PROCESS | 7116 | 03:16:06 INFO - TEST-INFO | 7116: exit 0 03:16:06 INFO - TEST-OK | kraken | took 60623ms 03:16:06 INFO - SUITE-END | took 1179s 03:16:07 INFO - Completed test suite (00:19:39) 03:16:07 INFO - javascript benchmark 03:16:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.6258330292017, 3294.8187849668257, 3311.6191637961633, 3320.9003729888113, 3357.4628059510483, 5601.383847776751, 5683.602147849652, 5716.22830917826, 5722.685252311116, 5741.913871291934, 5697.715114244292, 5721.141828725693, 5807.883842323151, 5813.854653633662, 5842.47417732404, 5149.74251287436, 5177.275181474578, 5196.0647083524955, 5253.290805741233, 5302.178162384817, 5313.574914006889, 5326.813561525348, 5327.094393953037, 5330.598671830667, 5375.247465354853, 5171.870703232449, 5288.0745869472885, 5308.654937429054, 5327.946720532784, 5361.892762144755, 5161.458046905096, 5217.921731174036, 5225.581953443715, 5264.473552644743, 5284.709340986245, 5210.921836172461, 5226.608004399685, 5238.580913526908, 5248.317718696583, 5271.499207575274, 5744.994625940443, 5767.5962682612235, 5780.1907732917425, 5802.216700745387, 5851.180834683148, 6137.438273608336, 6162.198914141178, 6184.783532576384, 6194.132821405007, 6278.497720182374, 6231.034189700558, 6310.684465776692, 6323.620582765003, 6323.7786677466065, 6323.9051414228825, 5830.4169583041785, 5862.501687356623, 5863.589548731547, 5864.912026319608, 5897.970510147507, 6198.318184999646, 6243.406876346739, 6254.906176407358, 6304.621722696653, 6312.0531920211415, 6178.289496707936, 6179.783707570214, 6232.0, 6237.719302631302, 6243.875122497525, 6165.907511387333, 6310.7791227306825, 6313.40022697843, 6317.4946004319545, 6317.96841015792, 6134.467201660938, 6182.845428864224, 6187.0, 6205.410486003822, 6269.435750782452, 6308.0, 6310.652914089677, 6311.652859092702, 6328.6835658216905, 6342.112104305401, 4979.3526841510375, 4985.850424487271, 5048.3184770056305, 5050.4949505049935, 5054.949450505448, 4399.934000989988, 4429.247028005247, 4436.179306828247, 4445.755483448376, 4498.887527811766, 5816.389279125716, 5841.357450680422, 5855.882882342329, 5894.823155305262, 5900.967330717107, 5241.659292145999, 6275.309715931244, 6288.622682639057, 6302.180716506825, 6336.20797400325, 5671.688057156814, 5772.9711351442975, 5797.304323481209, 5832.679202643895, 5842.941570584325, 5437.401885792559, 5437.45625437461, 5438.293021907127, 5457.935702538047, 5492.0, 6367.235931688227, 6381.234251889803, 6389.744410223632, 6391.328910464427, 6402.6158430494315, 6154.353792851865, 6292.0, 6294.8111556653375, 6295.338989406229, 6305.085762564311, 6237.5009999200865, 6287.591306565058, 6355.046742988588, 6363.427291543783, 6363.936360636334, 6118.862843290023, 6121.418465245794, 6139.26328840542, 6143.1706719592285, 6148.631082135086, 6235.314115447207, 6246.46905013079, 6250.1874756281395, 6263.342349053284, 6274.905876411949, 6028.09578563219, 6051.1830902829315, 6068.150458935665, 6131.938680613137, 6133.53998450127, 6122.051082082285, 6123.14276001369, 6140.662263575547, 6143.385661433821, 6186.752529898934, 5933.228680271537, 6085.344337789054, 6090.695465226632, 6101.755929762938, 6136.907946380718, 5970.880582388415, 6117.96941015292, 6152.169457123231, 6162.07568864656, 6203.844903877439, 6085.330613632408, 6105.877882442415, 6113.663748493876, 6117.724702388314, 6122.6938653068055], "value": 5746.949112685027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.93910852480656, 456.42262537889565, 472.4543152658676, 509.8604618677258, 519.3897170824281, 30655.38689226214, 31165.68834311659, 32684.836575817117, 34214.80248191314, 42185.789071054605, 40334.19331613374, 42930.7853460733, 42993.35509967353, 43148.784256078674, 43186.35220471695, 9149.405288656233, 9371.25029997602, 9372.578233979488, 9377.624895004192, 9387.43675379476, 8406.201410865959, 8618.827623447527, 9223.354365194438, 11108.61119860805, 11244.100471962265, 11294.830577541303, 11340.092792576574, 11347.262427942158, 11353.148513861493, 11386.658400248005, 11284.661460156209, 11333.829992550118, 11362.94318528402, 11364.772704545945, 11389.82915256276, 8331.0, 8555.10171431997, 10901.12790976728, 11142.777144457146, 11197.944010279978, 39998.60001399978, 40093.79953100245, 40691.96540173009, 40705.59294407048, 41096.1780764383, 3634.491171236029, 3791.696664266852, 4060.451839001756, 4077.041895154636, 4092.202020605983, 30367.0, 30436.54345184824, 30572.69427305721, 31096.844515777502, 31511.84244078765, 3165.240342317827, 3188.8883889063773, 3200.4079245339685, 3234.8706051758136, 3300.85146168423, 393331.0, 466493.66753166355, 466570.0, 468118.0, 468230.0, 61197.69401153055, 61354.69322653447, 61407.0, 61423.6928815362, 61478.69260653668, 64562.677186613764, 64733.0, 64851.67574162099, 64892.0, 64935.0, 15825.52523424299, 16121.355145794038, 16121.516354509384, 16179.595510112342, 16182.919085404734, 11145.665630031112, 12305.753884922431, 12329.630111096682, 12425.254484730945, 12448.564300249447, 14532.782008269884, 14968.251587420586, 16697.666046678998, 16895.577610559587, 17105.401310954057, 7412.777616671508, 7602.847943041219, 7606.429517786078, 7650.540967541965, 7664.4634875559295, 870.0864092702637, 877.8814859993947, 889.9199072083414, 902.9503377314179, 913.6665117232295, 28410.85794571014, 29530.409391812045, 30132.0, 30259.848700756356, 30607.387852243275, 962.7243901830103, 975.5073687787622, 1020.9387436753818, 1024.7182024943052, 1066.3495267886583, 14266.785998210034, 14351.0, 14409.279536023158, 14420.711585768435, 14554.490592829201, 616739.0, 618396.0, 621117.0, 622007.0, 622146.0, 52041.0, 52072.47927520752, 52186.478135218924, 52234.0, 52325.7383713079, 1429.328215738601, 1436.755751522223, 1452.7893455449112, 1457.4607395263608, 1463.0, 22335.77664223402, 25285.747142529075, 27102.593461097706, 27337.31656708598, 27381.589276160474, 46396.7680161597, 46639.53360466352, 46700.53299466962, 46725.53274467212, 46784.53215467802, 504617.29222184356, 523213.0, 523698.10415167455, 526333.0, 527423.0, 24122.87938560296, 24322.0, 24419.14532991337, 24888.0, 25852.35369115787, 35914.820425897706, 36300.09249768777, 41681.37477937894, 43944.34083488686, 44546.0, 35287.470687940215, 35309.64690353166, 35551.0, 36625.63374366222, 36789.033480480866, 35261.471077934366, 35357.646423535436, 36220.456693150154, 36237.456438153975, 36511.45232821563, 34823.65176348204, 34964.47553286652, 35436.46845297374, 35562.93311200668, 35898.28203435969, 22256.666150008088, 30314.090577282717, 31033.844830775703, 31757.20606984844, 31850.840745796122, 16514.504564863073, 18922.905385472983, 21341.14635414566, 23414.03004154685, 23504.177353792536], "value": 19254.16698395359, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.22342150830616, 395.7328803057935, 396.3183324681548, 401.72481849932797, 421.2775090719417, 14354.0, 16963.660726785456, 19854.70217946732, 21085.789142108595, 21183.576328473442, 16096.0, 17904.28382864684, 19894.801051989474, 20570.588588228227, 20689.793102068976, 5724.398938111491, 6051.667158306292, 6061.242344706911, 6067.484263837579, 6070.028795392738, 5774.595778295521, 5884.0, 5994.820155395323, 6005.459508644221, 6035.094735789645, 5964.731587078571, 6160.691965401712, 6164.568480206387, 6184.5052395808225, 6201.565890387675, 4959.677620954644, 6051.576389652726, 6087.54343424245, 6104.236970378703, 6129.1419201311855, 5804.071348584249, 5913.881722365529, 5915.763369465216, 5921.259842519685, 5931.317898441691, 22099.895005249833, 23564.64653030206, 24654.50690986188, 24713.50572988548, 24915.0, 2796.6224559684388, 2871.2821794551364, 2883.5098033334384, 2888.79778415511, 2892.1612732307603, 9822.852657210147, 9853.20551228279, 9896.158826499755, 10333.58665653373, 10444.42555659446, 1811.7191835265555, 1859.739636450898, 1861.3485280151974, 1869.401791426744, 1872.1481725814722, 101209.87901209894, 106862.0, 139383.30308348493, 139961.0, 142117.0, 11320.26418282809, 11523.942380288212, 11585.594504192313, 11650.563083890273, 11874.525018999144, 15195.468158614396, 15218.46735364279, 15234.847651523565, 15247.161406122548, 15255.389784408499, 7461.515001524992, 7649.923500764921, 7779.611019449005, 7810.531368117931, 7918.089419716691, 6993.335633114948, 7437.479376443597, 8105.716299929474, 8211.630476628567, 8213.646767213386, 4586.403767510203, 4621.329907163443, 4623.445186577632, 4638.628909687217, 4709.1994360958715, 1709.239388472118, 1990.243707391211, 2019.7677267114177, 2028.1177687705895, 2028.3103744726864, 997.5012493753123, 1000.4997501249376, 1002.4286156890648, 1006.3458751811381, 1053.2942928238099, 19314.13086411115, 20460.0, 20915.163393464394, 21090.47273818136, 21148.165888316867, 1013.7719013222113, 1023.150784848574, 1055.904968552834, 1058.5554067291755, 1060.151878497199, 9384.765380865396, 11001.119910407147, 11001.449927503592, 11024.393658348707, 11074.446277686244, 712041.0, 717765.4111729407, 728277.0, 732066.0, 734874.0, 135486.0, 139153.0, 149861.0, 150017.0, 157354.0, 1009.8838633557089, 1049.7900419916048, 1055.350959160111, 1070.9999999999843, 1071.4321409652896, 18195.363162289257, 18835.0, 18872.433826985212, 18894.622107557498, 18914.52713682114, 41135.0, 46087.0, 51401.7429912848, 52027.21959170691, 56896.715516422155, 78303.60848195723, 78793.60603196947, 83986.0, 84719.0, 86924.56537717271, 6956.686949087202, 7954.284114429498, 7994.360451163777, 8290.958545207235, 11897.583584574499, 12543.435545400296, 12549.74900502003, 13063.0, 13173.670658233237, 13414.0, 10588.258821882395, 10715.142788577052, 11071.889281107085, 11084.556617735201, 11597.014253788522, 11350.716232094264, 11354.489047993025, 11550.422478875855, 11596.840315968335, 11893.405329733652, 10195.184385249015, 10336.227277043674, 11066.114710822954, 11375.601853935073, 11474.196806223817, 12232.204906681038, 12463.314517701614, 12465.252084874937, 12666.303353315656, 12669.873301266869, 10924.50839712199, 11080.168987326144, 11200.271982321123, 11333.619939812403, 11754.823677645014], "value": 9912.73839302616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.8726171013752, 1458.8395276519589, 1467.4130347860855, 1492.0972811449074, 1500.2123884960395, 8030.91969080309, 8473.983122025365, 8481.067082620923, 8495.660173593064, 8496.32029437645, 7349.522281051742, 7628.466007379472, 7645.311921927026, 7804.92195078049, 8036.598170091486, 2248.291788086756, 2280.213326402397, 2285.6228722260807, 2287.553926984239, 2288.6338185890263, 2010.808973147556, 2277.578647950126, 2313.9421514462188, 2345.5074434368803, 2348.0842471436154, 2033.7695694105, 2203.151786562177, 2223.613222450741, 2243.3270018994317, 2294.9311520654323, 2134.722486076808, 2306.5156317173246, 2306.8269879759087, 2310.4108452344713, 2312.6877871487386, 2219.212179676224, 2333.8132949364012, 2334.8365614407, 2340.719113706349, 2348.38941875112, 8365.07984121746, 8435.029971553227, 8440.62017209227, 8451.0, 8455.619497122645, 5070.492950704936, 5154.226865970135, 5177.016366890279, 5179.61152913533, 5196.194589838581, 3320.6181289151814, 3343.983280083584, 3406.1654894550993, 3517.9824100879587, 3522.7181825453904, 1176.6352430746497, 1180.6989217749506, 1215.775081609905, 1233.9208433789095, 1233.969150771229, 10655.733606659818, 10782.0, 10785.784284314348, 10786.0, 10790.73023174419, 3925.509311336083, 4372.3878656988045, 4605.746683932416, 4690.437147542249, 4696.365990591226, 8732.083131271253, 9332.72001839946, 9333.859992100124, 9336.253099752004, 9343.299252556086, 5208.166693329125, 5226.059309324358, 5233.188855727369, 5234.42421333653, 5241.135212689864, 4679.274712419512, 4749.691270067435, 4793.664443488922, 4850.854474365775, 4884.755762211875, 3178.761592880543, 3782.432635104756, 3843.7501562398356, 3887.1253967857006, 3906.1015966327905, 1280.7246442015012, 1284.5825106840314, 1286.1961274203622, 1297.202220634303, 1304.4130141436392, 712.5938215217276, 757.2541047068632, 787.145946647882, 788.5347644889542, 811.5617566514017, 4239.8092085856215, 4417.712848664826, 5333.200019997032, 5415.296011518478, 5605.383407825218, 564.7035306464139, 577.376433451871, 578.1847594891183, 579.1168468086203, 583.1224007868132, 3560.483729859208, 3586.7847929124337, 3641.6358364163902, 3642.3261696586214, 3705.6479634434686, 9504.239660827117, 9902.257330700082, 9911.0, 9913.851292230622, 9925.751856203653, 9769.853452198222, 9866.0, 9937.602495900082, 9952.203823694088, 9960.352577082467, 7599.924000760032, 7665.846683066307, 7730.806729831799, 7808.219178082147, 7822.647980840876, 5234.869128271824, 5328.440513746001, 5348.57211423093, 5411.594130440154, 5577.8047768327915, 8236.917630823615, 8844.823103537765, 9015.0, 9137.725868223964, 9145.268378529834, 7787.338076263581, 8970.282377409922, 9050.230730387992, 9404.059594040815, 9452.905470945203, 5860.648361098348, 7006.544574602634, 7095.006699062033, 7096.467764917755, 7100.964495177491, 7609.162992070978, 7654.846903062019, 7756.728514501965, 7757.418193635387, 7768.0, 6929.099217101744, 7006.754763583454, 7010.053642758162, 7028.402585780062, 7031.0, 6833.214180369122, 6950.096487456598, 6952.409045231212, 6960.23437421873, 7009.754658586925, 6111.419415155553, 6268.749250029948, 6295.3704629538515, 6308.684565771785, 6317.399847014526, 4096.242195193899, 4770.522947705202, 4789.95210047909, 5011.248312753116, 5044.192929131322, 4735.479097299363, 4815.831445899376, 4817.27740838877, 4878.80484780619, 4884.316195732529], "value": 4272.998929374814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.3269297939227, 330.7250549133092, 337.701134495971, 351.7537723593485, 374.7320665724007, 4621.6533759968015, 4737.886596649789, 5352.501299636103, 5399.649022813514, 5491.890162196753, 4182.059036716737, 4372.366006928994, 4399.690162664603, 5266.894662106755, 5313.362396512424, 3441.434147462911, 3868.6905047596197, 3888.4556162137324, 4042.4542686737354, 4082.122343696105, 3855.9421608675893, 3965.2267807777494, 3978.9204215915665, 4081.653059489947, 4093.22228776533, 3406.8807591734294, 3887.650111489965, 4051.3517837146064, 4071.979640101795, 4076.2458945095104, 4003.7597744135446, 4038.1020920167475, 4049.5950404959267, 4056.837726490937, 4075.918481630351, 3344.8494817733263, 3444.896653100411, 3502.073859377332, 3502.3889011054944, 3549.680528752399, 4625.606823420013, 5152.9742351288005, 5207.921881171786, 5215.869603259911, 5250.894982100374, 4590.701604395737, 4597.655215821051, 4601.654875884322, 4603.884902877421, 4604.562566556172, 5303.469653034705, 5324.094903866352, 5557.888842223133, 5650.880919655129, 5699.487046165824, 3255.1335753049107, 3789.2758794748324, 3799.2591444668024, 3820.7134464915243, 3822.0635944193573, 5447.945520544784, 5510.421405752419, 5616.9608622404985, 5893.381194974509, 5905.763769449174, 3392.456432323287, 3764.6235376462137, 3798.0315019669806, 3905.5508616508896, 3910.335243008695, 3266.4283750343593, 3282.786618869766, 3907.433422153772, 3927.546807681119, 3947.684185265172, 4077.8989672788775, 4278.422412974271, 4319.028218650778, 4456.866294011184, 4574.977125114353, 4703.553162449562, 4741.881452963704, 5602.663840169603, 5639.798350229105, 5648.15277708347, 1245.6698974771693, 1265.3609926986996, 1268.733565951142, 1281.0, 1282.0320657903223, 811.5414790643267, 828.8300898315831, 843.9367047471465, 866.2982983783156, 876.5748611923212, 4690.833687261085, 4928.623892633557, 5020.7406667, 5039.21892106724, 5060.51925067118, 4619.3994780678295, 4779.737114458738, 5176.689398636094, 5470.781168753205, 5567.46894603979, 4604.033153037833, 4755.643326750507, 4841.538300115434, 4862.975685121552, 5050.6464547482055, 2374.6016523311578, 2607.191770551135, 2869.43615729428, 2876.2234196767176, 2881.6109825173753, 4873.951260487421, 4964.44331169448, 5614.466625670555, 5620.611240222889, 5659.0, 4698.906021879611, 5185.585153187736, 5496.587755918242, 5510.752016159283, 5623.746931388016, 4801.18379875422, 5291.100512912814, 5411.729413529387, 5600.131979543095, 5656.918812276736, 4442.600165985077, 5232.869178270574, 5401.783928642811, 5459.918101228564, 5475.123980163155, 4472.2942619715905, 4686.671932964659, 5255.3168088148295, 5308.654937429054, 5366.007288651612, 4671.649626277975, 4843.418789745253, 5433.8369848904595, 5606.831795046155, 5631.802886898939, 3158.463061279542, 3627.673509384168, 3635.2547727716283, 3644.6173151818675, 3658.35374081659, 5020.899582008266, 5186.8962620746615, 5423.647462914898, 5465.212741501783, 5500.4224556420995, 4698.8355407560575, 5014.9498505015945, 5563.471470210324, 5644.548436125018, 5707.229524014205, 4517.679505563343, 4754.5245475452175, 5223.0, 5562.3047119110115, 5590.776368945197, 4543.65922555803, 5489.682476205761, 5503.807366742145, 5521.889562208814, 5591.636543624814, 5386.865328366822, 5394.163904594794, 5542.7782888685615, 5578.3584887738425, 5608.831735047955, 5250.921236181384, 5281.9471805281455, 5534.339698090476, 5541.362743284574, 5568.777248909998], "value": 3971.2966439670754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.9037579926709, 728.3117454005964, 754.5548126605302, 817.5544328341053, 841.4740787008121, 14860.33128509217, 15043.774343384857, 15521.456749013787, 15568.688626227497, 15603.0, 11409.030232430232, 14003.719925601481, 14054.086484378508, 14087.154770713738, 14089.0, 741.4587351233603, 859.4456575508777, 877.5787621941472, 878.1789027259501, 878.1832895407268, 674.7469698862926, 695.4818660098208, 700.5726506830829, 873.0614589316478, 873.4453621950043, 883.9911600884005, 888.506878682331, 917.0142097245455, 923.0169869089399, 926.3284119013729, 882.0429833630518, 905.8586181411404, 906.2613969614742, 906.8231694819513, 907.0883761819396, 514.7194778845538, 530.822174571519, 674.7638326585704, 674.8582797612507, 677.8169894128607, 11986.634902084113, 12047.698807529794, 12374.195677280948, 12396.442160102726, 15115.848841511664, 14016.509422170277, 14325.426982920671, 14438.0, 14456.27718614065, 14804.037737547025, 11718.945294923413, 11720.413979301002, 11889.702757431047, 11974.401279935968, 11990.100742444352, 3496.30073985204, 3654.6710796028483, 3672.2288319452946, 3774.2074164425503, 3798.2593394288124, 99982.0, 103162.0, 103484.48257758738, 104371.95628043698, 105556.0, 10591.57633694659, 10631.681049568526, 10635.94682026585, 10862.511186996604, 10892.0, 20464.181432742524, 20475.79524204739, 20814.895925520275, 20842.89578552128, 20845.478863028544, 7426.108866936002, 7433.516821406592, 7460.403167746567, 7497.737579184703, 7569.810754731066, 4261.786910654455, 4268.914621707549, 4316.0, 4318.870433886988, 4333.934990975138, 3543.7165026797793, 3587.7847329160336, 3649.635036496329, 3655.7806531607657, 3660.5058317127377, 634.3624657219465, 640.5868215001298, 642.495640921874, 654.5450911616476, 658.716751796732, 583.4194975998909, 659.8548319369731, 694.9548279361825, 703.8521910398771, 716.3266529462393, 9223.76940576491, 9715.0, 9918.454485003394, 9954.710461533934, 9956.854961679355, 666.8532922756985, 691.6507163882208, 691.7993781803322, 710.559453139057, 715.427657873699, 4015.8996025099605, 4770.284457331359, 4817.662763606584, 4836.322914791932, 4938.578975934536, 90388.5480572593, 95289.52355238318, 96973.5453968191, 97289.0, 99331.50334248427, 82934.58532707297, 84238.15761842304, 84241.0, 84922.5753871239, 86165.0, 68949.31050689428, 69462.0, 69498.30501694918, 70264.64867675527, 71046.64476677687, 9215.67745128944, 9234.584443699916, 9240.861387079334, 9282.21101206405, 9286.210672092677, 43566.782166090234, 45415.77292113518, 50347.13371020749, 50467.49532504775, 50978.74510627423, 65959.0, 66762.33237667561, 67440.6627966857, 68105.97841032488, 69036.6548167256, 9555.61777528891, 11185.608503702331, 11596.0, 11645.0, 11719.238249513754, 12222.20555663879, 12323.75352492963, 12402.25586464815, 12678.366081696062, 13044.608661740163, 9884.333326708702, 11838.348890811088, 12046.337451440255, 12134.271943683407, 12135.635930921733, 8249.711260105867, 10084.546195421077, 10224.437655928996, 10523.842142367717, 10614.363138211733, 10626.787464250827, 11015.490533562772, 11516.021138203347, 11700.70748231301, 11754.23597466162, 9262.39794413361, 9742.75643108928, 9866.753331166492, 10150.23873209527, 10168.644097456554, 8955.283338312865, 9455.338126331091, 9494.715158545254, 9670.419774813534, 9714.0], "value": 7102.135112510324, "unit": "score"}], "name": "dromaeo_css", "value": 7137.450780254033, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 111.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 138.0, 147.0, 114.0, 139.0, 138.0, 108.0, 131.0, 112.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 189.0, 185.0, 185.0, 183.0, 182.0, 170.0, 231.0, 258.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 58.0, 88.0, 60.0, 58.0, 58.0, 58.0, 75.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 75.0, 86.0, 70.0, 68.0, 70.0, 82.0, 88.0, 99.0, 114.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 87.0, 88.0, 85.0, 89.0, 87.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 113.0, 150.0, 95.0, 95.0, 95.0, 107.0, 128.0], "value": 106.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 108.0, 132.0, 88.0, 89.0, 88.0, 87.0, 89.0, 88.0, 88.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 53.0, 54.0, 75.0, 81.0, 84.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 81.0, 75.0, 76.0, 71.0, 72.0, 97.0, 105.0, 107.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 89.0, 87.0, 87.0, 87.0, 90.0, 89.0, 86.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 144.0, 146.0, 152.0, 137.0, 139.0, 144.0, 201.0, 152.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 175.0, 175.0, 175.0, 175.0, 174.0, 173.0, 175.0, 174.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 78.0, 86.0, 88.0, 87.0, 73.0, 67.0, 65.0, 66.0], "value": 74.8, "unit": "score"}], "name": "kraken", "value": 1508.0, "alertThreshold": 2.0}]} 03:16:07 INFO - Return code: 0 03:16:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:07 ERROR - # TBPL SUCCESS # 03:16:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:07 INFO - 2017-01-13 03:16:07.216 screenresolution[7120:137351] starting screenresolution argv=screenresolution get 03:16:07 INFO - 2017-01-13 03:16:07.219 screenresolution[7120:137351] Display 0: 1600x1200x32@60 03:16:07 INFO - 2017-01-13 03:16:07.226 screenresolution[7121:137354] starting screenresolution argv=screenresolution list 03:16:07 INFO - Available Modes on Display 0 03:16:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:07 INFO - Intel Iris: 03:16:07 INFO - Chipset Model: Intel Iris 03:16:07 INFO - Type: GPU 03:16:07 INFO - Bus: Built-In 03:16:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:07 INFO - Vendor: Intel (0x8086) 03:16:07 INFO - Device ID: 0x0a2e 03:16:07 INFO - Revision ID: 0x0009 03:16:07 INFO - Displays: 03:16:07 INFO - Display: 03:16:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:07 INFO - Display Serial Number: 1600x1200 60 03:16:07 INFO - Main Display: Yes 03:16:07 INFO - Mirror: Off 03:16:07 INFO - Online: Yes 03:16:07 INFO - Rotation: Supported 03:16:07 INFO - Return code: 0 03:16:07 INFO - Running post-action listener: _resource_record_post_action 03:16:07 INFO - [mozharness: 2017-01-13 11:16:07.465458Z] Finished run-tests step (success) 03:16:07 INFO - Running post-run listener: _resource_record_post_run 03:16:07 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1200128; Write bytes: 552341504; Read time: 12; Write time: 1682 03:16:07 INFO - TinderboxPrint: CPU usage
53.8% 03:16:07 INFO - TinderboxPrint: I/O read bytes / time
1,200,128 / 12 03:16:07 INFO - TinderboxPrint: I/O write bytes / time
552,341,504 / 1,682 03:16:07 INFO - TinderboxPrint: CPU idle
2,224.2 (46.2%) 03:16:07 INFO - TinderboxPrint: CPU system
967.6 (20.1%) 03:16:07 INFO - TinderboxPrint: CPU user
1,617.9 (33.6%) 03:16:07 INFO - TinderboxPrint: Swap in / out
251,764,736 / 0 03:16:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249379328; Write bytes: 243271680; Read time: 18056; Write time: 534 03:16:07 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1163264; Write bytes: 297453568; Read time: 12; Write time: 1108 03:16:07 INFO - Running post-run listener: _upload_blobber_files 03:16:07 INFO - Blob upload gear active. 03:16:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:16:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:16:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:09 INFO - (blobuploader) - INFO - Done attempting. 03:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:11 INFO - (blobuploader) - INFO - Done attempting. 03:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:12 INFO - (blobuploader) - INFO - Done attempting. 03:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:14 INFO - (blobuploader) - INFO - Done attempting. 03:16:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:14 INFO - Return code: 0 03:16:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2760741cac35ea938f5c25c23d1fa9fe0c4e20a9fba8f072621278b7aaebc6ae3bce1c804f9a297b86dfb6a5f67786014bb1d157150e1833510d010d20945470", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/140fd6a9162a812f5b3973b15e09d28c492b0370579b5fbc787890a3e06f5f91cfa4d83c08c21eadb8ae305553126c918d8b604e4cc0447524cbf4a9eeb18598", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e414d7117319f29b841d8e35de021c2a8ff382d31acda59c46bccec0a51eee729c25a6c3bd09ab1b050f7d62d854184b073359ba4f459fcbc7a1253f9aca86c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7992e69bad74a23550ef6b45f7672f1831844a06ac078e5ba2d9c2fd63b7820b0bc8dc583e49233a78c00c9f4347bb388bb73171ede2745347ef2a20e86f126e"} 03:16:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:14 INFO - Contents: 03:16:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2760741cac35ea938f5c25c23d1fa9fe0c4e20a9fba8f072621278b7aaebc6ae3bce1c804f9a297b86dfb6a5f67786014bb1d157150e1833510d010d20945470", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/140fd6a9162a812f5b3973b15e09d28c492b0370579b5fbc787890a3e06f5f91cfa4d83c08c21eadb8ae305553126c918d8b604e4cc0447524cbf4a9eeb18598", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e414d7117319f29b841d8e35de021c2a8ff382d31acda59c46bccec0a51eee729c25a6c3bd09ab1b050f7d62d854184b073359ba4f459fcbc7a1253f9aca86c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7992e69bad74a23550ef6b45f7672f1831844a06ac078e5ba2d9c2fd63b7820b0bc8dc583e49233a78c00c9f4347bb388bb73171ede2745347ef2a20e86f126e"} 03:16:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:14 INFO - Copying logs to upload dir... 03:16:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.154593 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-13 03:16:14.830820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:14.834244) ========= 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.fHUSz82418/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.i6QVmIMlnC/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2760741cac35ea938f5c25c23d1fa9fe0c4e20a9fba8f072621278b7aaebc6ae3bce1c804f9a297b86dfb6a5f67786014bb1d157150e1833510d010d20945470", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/140fd6a9162a812f5b3973b15e09d28c492b0370579b5fbc787890a3e06f5f91cfa4d83c08c21eadb8ae305553126c918d8b604e4cc0447524cbf4a9eeb18598", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e414d7117319f29b841d8e35de021c2a8ff382d31acda59c46bccec0a51eee729c25a6c3bd09ab1b050f7d62d854184b073359ba4f459fcbc7a1253f9aca86c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7992e69bad74a23550ef6b45f7672f1831844a06ac078e5ba2d9c2fd63b7820b0bc8dc583e49233a78c00c9f4347bb388bb73171ede2745347ef2a20e86f126e"} build_url:https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011580 build_url: 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2760741cac35ea938f5c25c23d1fa9fe0c4e20a9fba8f072621278b7aaebc6ae3bce1c804f9a297b86dfb6a5f67786014bb1d157150e1833510d010d20945470", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/140fd6a9162a812f5b3973b15e09d28c492b0370579b5fbc787890a3e06f5f91cfa4d83c08c21eadb8ae305553126c918d8b604e4cc0447524cbf4a9eeb18598", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e414d7117319f29b841d8e35de021c2a8ff382d31acda59c46bccec0a51eee729c25a6c3bd09ab1b050f7d62d854184b073359ba4f459fcbc7a1253f9aca86c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7992e69bad74a23550ef6b45f7672f1831844a06ac078e5ba2d9c2fd63b7820b0bc8dc583e49233a78c00c9f4347bb388bb73171ede2745347ef2a20e86f126e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:14.869781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:14.870122) ========= 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.fHUSz82418/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.i6QVmIMlnC/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.005403 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:14.918671) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:16:14.919001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:16:14.919319) ========= ========= Total master_lag: 2.41 =========