builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0218 starttime: 1481646001.67 results: success (0) buildid: 20161213065402 builduid: 8d2b213e83244a0ba9816bb3dc0c8db2 revision: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.670249) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.670762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.671047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.700358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.700752) ========= 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.Ed5657lxXD/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.w7lwDFbn9N/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-13 08:20:01-- 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% 68.3M=0s 2016-12-13 08:20:01 (68.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.943846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.944158) ========= 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.Ed5657lxXD/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.w7lwDFbn9N/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.024851 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.993940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-12-13 08:20:01.994510) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fee42adb860ed03be0de7dcb91cbfd2efcd8c01e --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 fee42adb860ed03be0de7dcb91cbfd2efcd8c01e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ed5657lxXD/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.w7lwDFbn9N/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-13 08:20:02,092 truncating revision to first 12 chars 2016-12-13 08:20:02,092 Setting DEBUG logging. 2016-12-13 08:20:02,093 attempt 1/10 2016-12-13 08:20:02,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fee42adb860e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 08:20:04,068 unpacking tar archive at: mozilla-central-fee42adb860e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.255320 ========= master_lag: 3.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-12-13 08:20:07.336421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.339831) ========= script_repo_revision: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.340258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.340540) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.373334) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-13 08:20:07.373652) ========= /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.Ed5657lxXD/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.w7lwDFbn9N/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:20:07 INFO - MultiFileLogger online at 20161213 08:20:07 in /builds/slave/test 08:20:07 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 08:20:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:07 INFO - {'append_to_log': False, 08:20:07 INFO - 'base_work_dir': '/builds/slave/test', 08:20:07 INFO - 'blob_upload_branch': 'Firefox', 08:20:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:07 INFO - 'branch': 'Firefox', 08:20:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:07 INFO - 'config_files': ('talos/mac_config.py',), 08:20:07 INFO - 'default_actions': ('clobber', 08:20:07 INFO - 'read-buildbot-config', 08:20:07 INFO - 'download-and-extract', 08:20:07 INFO - 'populate-webroot', 08:20:07 INFO - 'create-virtualenv', 08:20:07 INFO - 'install', 08:20:07 INFO - 'run-tests'), 08:20:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:07 INFO - 'download_minidump_stackwalk': True, 08:20:07 INFO - 'download_symbols': 'ondemand', 08:20:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:07 INFO - 'installer_path': 'installer.exe', 08:20:07 INFO - 'log_level': 'info', 08:20:07 INFO - 'log_name': 'talos', 08:20:07 INFO - 'log_to_console': True, 08:20:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:20:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:20:07 INFO - 'opt_config_files': (), 08:20:07 INFO - 'pip_index': False, 08:20:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:20:07 INFO - 'cmd': ('bash', 08:20:07 INFO - '-c', 08:20:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:20:07 INFO - 'enabled': True, 08:20:07 INFO - 'halt_on_failure': False, 08:20:07 INFO - 'name': 'check_screen_resolution'},), 08:20:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:20:07 INFO - 'cmd': ('bash', 08:20:07 INFO - '-c', 08:20:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:20:07 INFO - 'enabled': True, 08:20:07 INFO - 'halt_on_failure': False, 08:20:07 INFO - 'name': 'check_screen_resolution'},), 08:20:07 INFO - 'run_cmd_checks_enabled': True, 08:20:07 INFO - 'sps_profile': False, 08:20:07 INFO - 'sps_profile_interval': 0, 08:20:07 INFO - 'suite': 'dromaeojs', 08:20:07 INFO - 'system_bits': '32', 08:20:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:07 INFO - 'title': 't-yosemite-r7-0218', 08:20:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:07 INFO - 'use_talos_json': True, 08:20:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:07 INFO - 'work_dir': 'build'} 08:20:07 INFO - [mozharness: 2016-12-13 16:20:07.578614Z] Running clobber step. 08:20:07 INFO - Running pre-action listener: _resource_record_pre_action 08:20:07 INFO - Running main action method: clobber 08:20:07 INFO - rmtree: /builds/slave/test/build 08:20:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:09 INFO - Running post-action listener: _resource_record_post_action 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.920592Z] Finished clobber step (success) 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.920744Z] Running read-buildbot-config step. 08:20:09 INFO - Running pre-action listener: _resource_record_pre_action 08:20:09 INFO - Running main action method: read_buildbot_config 08:20:09 INFO - Using buildbot properties: 08:20:09 INFO - { 08:20:09 INFO - "project": "", 08:20:09 INFO - "product": "firefox", 08:20:09 INFO - "script_repo_revision": "production", 08:20:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:20:09 INFO - "repository": "", 08:20:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:20:09 INFO - "buildid": "20161213065402", 08:20:09 INFO - "pgo_build": "False", 08:20:09 INFO - "basedir": "/builds/slave/test", 08:20:09 INFO - "buildnumber": 43, 08:20:09 INFO - "slavename": "t-yosemite-r7-0218", 08:20:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:20:09 INFO - "platform": "yosemite_r7", 08:20:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:20:09 INFO - "branch": "mozilla-central", 08:20:09 INFO - "repo_path": "mozilla-central", 08:20:09 INFO - "revision": "fee42adb860ed03be0de7dcb91cbfd2efcd8c01e", 08:20:09 INFO - "stage_platform": "macosx64", 08:20:09 INFO - "builduid": "8d2b213e83244a0ba9816bb3dc0c8db2", 08:20:09 INFO - "slavebuilddir": "test" 08:20:09 INFO - } 08:20:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 08:20:09 INFO - Running post-action listener: _resource_record_post_action 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.924305Z] Finished read-buildbot-config step (success) 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.924412Z] Running download-and-extract step. 08:20:09 INFO - Running pre-action listener: _resource_record_pre_action 08:20:09 INFO - Running main action method: download_and_extract 08:20:09 INFO - mkdir: /builds/slave/test/build/tests 08:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:09 INFO - trying https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:20:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 08:20:10 INFO - Downloaded 1235 bytes. 08:20:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:20:10 INFO - Using the following test package requirements: 08:20:10 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:20:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 08:20:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 08:20:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'jsshell-mac64.zip'], 08:20:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 08:20:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:20:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 08:20:10 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 08:20:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 08:20:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:10 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 08:20:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 08:20:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:20:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:20:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:20:11 INFO - Expected file size: 16276173 08:20:11 INFO - Obtained file size: 16276173 08:20:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 08:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:20:19 INFO - Expected file size: 16276173 08:20:19 INFO - Obtained file size: 16276173 08:20:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 08:20:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 08:20:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 08:20:27 INFO - Expected file size: 14409734 08:20:27 INFO - Obtained file size: 14409734 08:20: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')]} 08:20:27 INFO - trying https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:20:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 08:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 08:20:29 INFO - Downloaded 69713578 bytes. 08:20:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:20:29 INFO - mkdir: /builds/slave/test/properties 08:20:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:29 INFO - Contents: 08:20:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:20:30 INFO - Running post-action listener: _resource_record_post_action 08:20:30 INFO - Running post-action listener: set_extra_try_arguments 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.023755Z] Finished download-and-extract step (success) 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.023880Z] Running populate-webroot step. 08:20:30 INFO - Running pre-action listener: _resource_record_pre_action 08:20:30 INFO - Running main action method: populate_webroot 08:20:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:30 INFO - '--tppagecycles', 08:20:30 INFO - '7'], 08:20:30 INFO - 'tests': ['tsvgm']}}, 08:20:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:20:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:20:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:20:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['damp', 'tps']}, 08:20:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'tests': ['damp', 'tps']}, 08:20:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['dromaeo_dom']}, 08:20:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['basic_compositor_video']}, 08:20:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:20:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tsvgx', 08:20:30 INFO - 'tsvgr_opacity', 08:20:30 INFO - 'tart', 08:20:30 INFO - 'tscrollx', 08:20:30 INFO - 'cart', 08:20:30 INFO - 'tsvg_static']}, 08:20:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:20:30 INFO - 'tsvgr_opacity', 08:20:30 INFO - 'tart', 08:20:30 INFO - 'tscrollx', 08:20:30 INFO - 'cart', 08:20:30 INFO - 'tsvg_static']}, 08:20:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tp5o']}, 08:20:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:20:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s', 08:20:30 INFO - '--xperf_path', 08:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:30 INFO - 'tests': ['tp5n']}, 08:20:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--xperf_path', 08:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:30 INFO - 'tests': ['tp5n']}}, 08:20:30 INFO - 'talos.zip': {'path': '', 08:20:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:30 INFO - Running post-action listener: _resource_record_post_action 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.042328Z] Finished populate-webroot step (success) 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.042439Z] Running create-virtualenv step. 08:20:30 INFO - Running pre-action listener: _resource_record_pre_action 08:20:30 INFO - Running main action method: create_virtualenv 08:20:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:20:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:30 INFO - Using real prefix '/tools/python27' 08:20:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:33 INFO - Installing pip.................done. 08:20:33 INFO - Return code: 0 08:20:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:20:34 INFO - Reading from file tmpfile_stdout 08:20:34 INFO - Output received: 08:20:34 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) 08:20:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:34 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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:34 INFO - 'HOME': '/Users/cltbld', 08:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:34 INFO - 'LOGNAME': 'cltbld', 08:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:34 INFO - 'MOZ_NO_REMOTE': '1', 08:20:34 INFO - 'NO_EM_RESTART': '1', 08:20:34 INFO - 'PAGER': '/bin/cat', 08:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:34 INFO - 'PWD': '/builds/slave/test', 08:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:34 INFO - 'SHELL': '/bin/bash', 08:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:34 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:34 INFO - 'USER': 'cltbld', 08:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:34 INFO - 'XPC_FLAGS': '0x0', 08:20:34 INFO - 'XPC_SERVICE_NAME': '0', 08:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20: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 08:20:35 INFO - Cleaning up... 08:20:35 INFO - Return code: 0 08:20:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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', '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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:20: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 psutil>=3.1.1 08:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:35 INFO - 'HOME': '/Users/cltbld', 08:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:35 INFO - 'LOGNAME': 'cltbld', 08:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:35 INFO - 'MOZ_NO_REMOTE': '1', 08:20:35 INFO - 'NO_EM_RESTART': '1', 08:20:35 INFO - 'PAGER': '/bin/cat', 08:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:35 INFO - 'PWD': '/builds/slave/test', 08:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:35 INFO - 'SHELL': '/bin/bash', 08:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:35 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:35 INFO - 'USER': 'cltbld', 08:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:35 INFO - 'XPC_FLAGS': '0x0', 08:20:35 INFO - 'XPC_SERVICE_NAME': '0', 08:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:35 INFO - Downloading/unpacking psutil>=3.1.1 08:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:39 INFO - Installing collected packages: psutil 08:20:39 INFO - Running setup.py install for psutil 08:20:39 INFO - building 'psutil._psutil_osx' extension 08:20:39 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 08:20: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 08:20: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 08:20: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 08:20:40 INFO - building 'psutil._psutil_posix' extension 08:20: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 08:20:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:20:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:20:40 INFO - ^ 08:20:40 INFO - 1 warning generated. 08:20: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 08:20:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:40 INFO - Successfully installed psutil 08:20:40 INFO - Cleaning up... 08:20:40 INFO - Return code: 0 08:20:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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 08:20: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 08:20:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:40 INFO - 'HOME': '/Users/cltbld', 08:20:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:40 INFO - 'LOGNAME': 'cltbld', 08:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:40 INFO - 'MOZ_NO_REMOTE': '1', 08:20:40 INFO - 'NO_EM_RESTART': '1', 08:20:40 INFO - 'PAGER': '/bin/cat', 08:20:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:40 INFO - 'PWD': '/builds/slave/test', 08:20:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:40 INFO - 'SHELL': '/bin/bash', 08:20:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:40 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:40 INFO - 'USER': 'cltbld', 08:20:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:40 INFO - 'XPC_FLAGS': '0x0', 08:20:40 INFO - 'XPC_SERVICE_NAME': '0', 08:20:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:20:43 INFO - Installing collected packages: mozsystemmonitor 08:20:43 INFO - Running setup.py install for mozsystemmonitor 08:20:43 INFO - Successfully installed mozsystemmonitor 08:20:43 INFO - Cleaning up... 08:20:43 INFO - Return code: 0 08:20:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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 08:20: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 08:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:43 INFO - 'HOME': '/Users/cltbld', 08:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:43 INFO - 'LOGNAME': 'cltbld', 08:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:43 INFO - 'MOZ_NO_REMOTE': '1', 08:20:43 INFO - 'NO_EM_RESTART': '1', 08:20:43 INFO - 'PAGER': '/bin/cat', 08:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:43 INFO - 'PWD': '/builds/slave/test', 08:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:43 INFO - 'SHELL': '/bin/bash', 08:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:43 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:43 INFO - 'USER': 'cltbld', 08:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:43 INFO - 'XPC_FLAGS': '0x0', 08:20:43 INFO - 'XPC_SERVICE_NAME': '0', 08:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:44 INFO - Downloading/unpacking jsonschema==2.5.1 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:47 INFO - warning: no files found matching '*.txt' 08:20:47 INFO - no previously-included directories found matching 'build' 08:20:47 INFO - no previously-included directories found matching 'dist' 08:20:47 INFO - no previously-included directories found matching '.git*' 08:20:47 INFO - Installing collected packages: jsonschema, functools32 08:20:47 INFO - Running setup.py install for functools32 08:20:47 INFO - warning: no files found matching '*.txt' 08:20:47 INFO - no previously-included directories found matching 'build' 08:20:47 INFO - no previously-included directories found matching 'dist' 08:20:47 INFO - no previously-included directories found matching '.git*' 08:20:47 INFO - Successfully installed jsonschema functools32 08:20:47 INFO - Cleaning up... 08:20:47 INFO - Return code: 0 08:20:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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 08:20: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 08:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:47 INFO - 'HOME': '/Users/cltbld', 08:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:47 INFO - 'LOGNAME': 'cltbld', 08:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:47 INFO - 'MOZ_NO_REMOTE': '1', 08:20:47 INFO - 'NO_EM_RESTART': '1', 08:20:47 INFO - 'PAGER': '/bin/cat', 08:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:47 INFO - 'PWD': '/builds/slave/test', 08:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:47 INFO - 'SHELL': '/bin/bash', 08:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:47 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:47 INFO - 'USER': 'cltbld', 08:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:47 INFO - 'XPC_FLAGS': '0x0', 08:20:47 INFO - 'XPC_SERVICE_NAME': '0', 08:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:20:47 INFO - Cleaning up... 08:20:47 INFO - Return code: 0 08:20:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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 08:20: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 08:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:47 INFO - 'HOME': '/Users/cltbld', 08:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:47 INFO - 'LOGNAME': 'cltbld', 08:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:47 INFO - 'MOZ_NO_REMOTE': '1', 08:20:47 INFO - 'NO_EM_RESTART': '1', 08:20:47 INFO - 'PAGER': '/bin/cat', 08:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:47 INFO - 'PWD': '/builds/slave/test', 08:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:47 INFO - 'SHELL': '/bin/bash', 08:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:47 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:47 INFO - 'USER': 'cltbld', 08:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:47 INFO - 'XPC_FLAGS': '0x0', 08:20:47 INFO - 'XPC_SERVICE_NAME': '0', 08:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:51 INFO - Downloading docopt-0.6.1.tar.gz 08:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:51 INFO - Running setup.py install for blobuploader 08:20:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:52 INFO - Running setup.py install for requests 08:20:52 INFO - Running setup.py install for docopt 08:20:52 INFO - Successfully installed blobuploader requests docopt 08:20:52 INFO - Cleaning up... 08:20:52 INFO - Return code: 0 08:20:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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 08:20: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 08:20:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:52 INFO - 'HOME': '/Users/cltbld', 08:20:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:52 INFO - 'LOGNAME': 'cltbld', 08:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:52 INFO - 'MOZ_NO_REMOTE': '1', 08:20:52 INFO - 'NO_EM_RESTART': '1', 08:20:52 INFO - 'PAGER': '/bin/cat', 08:20:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:52 INFO - 'PWD': '/builds/slave/test', 08:20:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:52 INFO - 'SHELL': '/bin/bash', 08:20:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:52 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:52 INFO - 'USER': 'cltbld', 08:20:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:52 INFO - 'XPC_FLAGS': '0x0', 08:20:52 INFO - 'XPC_SERVICE_NAME': '0', 08:20:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-K0UVZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-LnSerI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-wLDtir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-27Snsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Y_nEbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-w2FpyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-BxO01y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-3EPr6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-iTKirP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-SNChOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:54 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-lX2Myb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:54 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-EyhF33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:54 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-QSnNM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:54 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-47COFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:54 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-6KuUDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:54 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-7yWDYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:54 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-OlUU9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:20:54 INFO - Running setup.py install for manifestparser 08:20:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:20:54 INFO - Running setup.py install for mozcrash 08:20:55 INFO - Running setup.py install for mozdebug 08:20:55 INFO - Running setup.py install for mozdevice 08:20:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozfile 08:20:55 INFO - Running setup.py install for mozhttpd 08:20:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozinfo 08:20:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozInstall 08:20:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozleak 08:20:56 INFO - Running setup.py install for mozlog 08:20:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for moznetwork 08:20:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for mozprocess 08:20:56 INFO - Running setup.py install for mozprofile 08:20:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for mozrunner 08:20:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for mozscreenshot 08:20:57 INFO - Running setup.py install for moztest 08:20:57 INFO - Running setup.py install for mozversion 08:20:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:20:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:20:57 INFO - Cleaning up... 08:20:57 INFO - Return code: 0 08:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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 08:20: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 08:20:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:20:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:57 INFO - 'HOME': '/Users/cltbld', 08:20:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:57 INFO - 'LOGNAME': 'cltbld', 08:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:57 INFO - 'MOZ_NO_REMOTE': '1', 08:20:57 INFO - 'NO_EM_RESTART': '1', 08:20:57 INFO - 'PAGER': '/bin/cat', 08:20:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:57 INFO - 'PWD': '/builds/slave/test', 08:20:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:57 INFO - 'SHELL': '/bin/bash', 08:20:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:20:57 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:20:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:57 INFO - 'USER': 'cltbld', 08:20:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:57 INFO - 'XPC_FLAGS': '0x0', 08:20:57 INFO - 'XPC_SERVICE_NAME': '0', 08:20:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-XyDFJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20: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)) 08:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-xH2e4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:57 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)) 08:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-bOEMjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:57 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)) 08:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-4Syv76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20: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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-psb_GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20: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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-7Uzg6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20: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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-xuKlvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20: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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-0QcFsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20: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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-TsHV7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20: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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-kM3XK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20: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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-RmYYMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:58 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)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-B0637C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-tUrVJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20: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)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:59 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-pzBvkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20: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)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:59 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-DNEiwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20: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)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:59 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-_DD6iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:59 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-UxSwoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20: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)) 08:20: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)) 08:20: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)) 08:20: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)) 08:20: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)) 08:20: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)) 08:20:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:02 INFO - Downloading blessings-1.6.tar.gz 08:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:02 INFO - Installing collected packages: blessings 08:21:02 INFO - Running setup.py install for blessings 08:21:02 INFO - Successfully installed blessings 08:21:02 INFO - Cleaning up... 08:21:02 INFO - Return code: 0 08:21:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:02 INFO - Reading from file tmpfile_stdout 08:21:02 INFO - Current package versions: 08:21:02 INFO - blessings == 1.6 08:21:02 INFO - blobuploader == 1.2.4 08:21:02 INFO - docopt == 0.6.1 08:21:02 INFO - functools32 == 3.2.3-2 08:21:02 INFO - jsonschema == 2.5.1 08:21:02 INFO - manifestparser == 1.1 08:21:02 INFO - mozInstall == 1.12 08:21:02 INFO - mozcrash == 1.0 08:21:02 INFO - mozdebug == 0.1 08:21:02 INFO - mozdevice == 0.49 08:21:02 INFO - mozfile == 1.2 08:21:02 INFO - mozhttpd == 0.7 08:21:02 INFO - mozinfo == 0.9 08:21:02 INFO - mozleak == 0.1 08:21:02 INFO - mozlog == 3.4 08:21:02 INFO - moznetwork == 0.27 08:21:02 INFO - mozprocess == 0.23 08:21:02 INFO - mozprofile == 0.28 08:21:02 INFO - mozrunner == 6.13 08:21:02 INFO - mozscreenshot == 0.1 08:21:02 INFO - mozsystemmonitor == 0.3 08:21:02 INFO - moztest == 0.7 08:21:02 INFO - mozversion == 1.4 08:21:02 INFO - psutil == 3.1.1 08:21:02 INFO - requests == 1.2.3 08:21:02 INFO - wsgiref == 0.1.2 08:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:02 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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:02 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 08:21:02 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 08:21:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:21:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:02 INFO - 'HOME': '/Users/cltbld', 08:21:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:02 INFO - 'LOGNAME': 'cltbld', 08:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:02 INFO - 'MOZ_NO_REMOTE': '1', 08:21:02 INFO - 'NO_EM_RESTART': '1', 08:21:02 INFO - 'PAGER': '/bin/cat', 08:21:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:02 INFO - 'PWD': '/builds/slave/test', 08:21:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:02 INFO - 'SHELL': '/bin/bash', 08:21:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:21:02 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:21:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:02 INFO - 'USER': 'cltbld', 08:21:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:02 INFO - 'XPC_FLAGS': '0x0', 08:21:02 INFO - 'XPC_SERVICE_NAME': '0', 08:21:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 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)) 08:21:02 INFO - Cleaning up... 08:21:02 INFO - Return code: 0 08:21:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:02 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 0x1102c33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110239570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fad66ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, '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.Ed5657lxXD/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.w7lwDFbn9N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:02 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 08:21:02 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 08:21:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:21:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:02 INFO - 'HOME': '/Users/cltbld', 08:21:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:02 INFO - 'LOGNAME': 'cltbld', 08:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:02 INFO - 'MOZ_NO_REMOTE': '1', 08:21:02 INFO - 'NO_EM_RESTART': '1', 08:21:02 INFO - 'PAGER': '/bin/cat', 08:21:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:02 INFO - 'PWD': '/builds/slave/test', 08:21:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:02 INFO - 'SHELL': '/bin/bash', 08:21:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:21:02 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:21:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:02 INFO - 'USER': 'cltbld', 08:21:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:02 INFO - 'XPC_FLAGS': '0x0', 08:21:02 INFO - 'XPC_SERVICE_NAME': '0', 08:21:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:03 INFO - Cleaning up... 08:21:03 INFO - Return code: 0 08:21:03 INFO - Running post-action listener: _resource_record_post_action 08:21:03 INFO - Running post-action listener: _start_resource_monitoring 08:21:03 INFO - Starting resource monitoring. 08:21:03 INFO - [mozharness: 2016-12-13 16:21:03.229264Z] Finished create-virtualenv step (success) 08:21:03 INFO - [mozharness: 2016-12-13 16:21:03.230268Z] Running install step. 08:21:03 INFO - Running pre-action listener: _resource_record_pre_action 08:21:03 INFO - Running main action method: install 08:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:03 INFO - Reading from file tmpfile_stdout 08:21:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:03 INFO - Reading from file tmpfile_stdout 08:21:03 INFO - Output received: 08:21:03 INFO - Usage: mozinstall [options] installer 08:21:03 INFO - Options: 08:21:03 INFO - -h, --help show this help message and exit 08:21:03 INFO - -d DEST, --destination=DEST 08:21:03 INFO - Directory to install application into. [default: 08:21:03 INFO - "/builds/slave/test"] 08:21:03 INFO - --app=APP Application being installed. [default: firefox] 08:21:03 INFO - mkdir: /builds/slave/test/build/application 08:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 08:21:25 INFO - Reading from file tmpfile_stdout 08:21:25 INFO - Output received: 08:21:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:21:25 INFO - Running post-action listener: _resource_record_post_action 08:21:25 INFO - [mozharness: 2016-12-13 16:21:25.146348Z] Finished install step (success) 08:21:25 INFO - [mozharness: 2016-12-13 16:21:25.146478Z] Running run-tests step. 08:21:25 INFO - Running pre-action listener: _resource_record_pre_action 08:21:25 INFO - Running main action method: run_tests 08:21:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:21:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:21:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:21:25 INFO - 2016-12-13 08:21:25.161 screenresolution[1628:7546] starting screenresolution argv=screenresolution get 08:21:25 INFO - 2016-12-13 08:21:25.163 screenresolution[1628:7546] Display 0: 1600x1200x32@60 08:21:25 INFO - 2016-12-13 08:21:25.169 screenresolution[1629:7548] starting screenresolution argv=screenresolution list 08:21:25 INFO - Available Modes on Display 0 08:21:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:21:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:21:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:21:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:21:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:21:25 INFO - Intel Iris: 08:21:25 INFO - Chipset Model: Intel Iris 08:21:25 INFO - Type: GPU 08:21:25 INFO - Bus: Built-In 08:21:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:21:25 INFO - Vendor: Intel (0x8086) 08:21:25 INFO - Device ID: 0x0a2e 08:21:25 INFO - Revision ID: 0x0009 08:21:25 INFO - Displays: 08:21:25 INFO - Display: 08:21:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:21:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:21:25 INFO - Display Serial Number: 1600x1200 60 08:21:25 INFO - Main Display: Yes 08:21:25 INFO - Mirror: Off 08:21:25 INFO - Online: Yes 08:21:25 INFO - Rotation: Supported 08:21:25 INFO - Return code: 0 08:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:25 INFO - Python 2.7.3 08:21:25 INFO - Return code: 0 08:21:25 INFO - grabbing minidump binary from tooltool 08:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:25 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 0x1100d8d30>, '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 0x10ff3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:25 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 08:21:25 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 08:21:25 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 08:21:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:25 INFO - Return code: 0 08:21:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:21:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:21:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:25 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/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 08:21:25 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/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0218 --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 08:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ed5657lxXD/Render', 08:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:25 INFO - 'HOME': '/Users/cltbld', 08:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:25 INFO - 'LOGNAME': 'cltbld', 08:21:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:25 INFO - 'MOZ_NO_REMOTE': '1', 08:21:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:25 INFO - 'NO_EM_RESTART': '1', 08:21:25 INFO - 'PAGER': '/bin/cat', 08:21:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:25 INFO - 'PWD': '/builds/slave/test', 08:21:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:25 INFO - 'SHELL': '/bin/bash', 08:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w7lwDFbn9N/Listeners', 08:21:25 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 08:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:25 INFO - 'USER': 'cltbld', 08:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:25 INFO - 'XPC_FLAGS': '0x0', 08:21:25 INFO - 'XPC_SERVICE_NAME': '0', 08:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:25 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/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 08:21:25 INFO - mozversion application_buildid: 20161213065402 08:21:25 INFO - mozversion application_changeset: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e 08:21:25 INFO - mozversion application_display_name: Nightly 08:21:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:25 INFO - mozversion application_name: Firefox 08:21:25 INFO - mozversion application_remotingname: firefox 08:21:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:21:25 INFO - mozversion application_vendor: Mozilla 08:21:25 INFO - mozversion application_version: 53.0a1 08:21:25 INFO - mozversion platform_buildid: 20161213065402 08:21:25 INFO - mozversion platform_changeset: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e 08:21:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:21:25 INFO - mozversion platform_version: 53.0a1 08:21:25 INFO - using testdate: 1481646085 08:21:25 INFO - actual date: 1481646085 08:21:25 INFO - starting webserver on 'localhost:49241' 08:21:25 INFO - SUITE-START | Running 2 tests 08:21:25 INFO - TEST-START | dromaeo_css 08:21:25 INFO - operating with platform_type : mac_ 08:21:25 INFO - Initialising browser for dromaeo_css test... 08:21:25 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpTDT3aj/profile http://localhost:49241/getInfo.html) 08:21:28 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 08:21:28 INFO - PROCESS | 1639 | colorDepth:24 08:21:28 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 08:21:28 INFO - PROCESS | 1639 | __metrics 08:21:28 INFO - PROCESS | 1639 | 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" 08:21:28 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:29 INFO - TEST-INFO | 1639: exit 0 08:21:29 INFO - Browser initialized. 08:21:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:29 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpTDT3aj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:41 INFO - PROCESS | 1641 | RSS: Main: 237404160 08:21:41 INFO - PROCESS | 1641 | 08:22:32 INFO - PROCESS | 1641 | 1481646152105 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:24:45 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:24:47 INFO - PROCESS | 1641 | RSS: Main: 392114176 08:24:47 INFO - PROCESS | 1641 | 08:27:50 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:27:50 INFO - PROCESS | 1641 | RSS: Main: 372260864 08:27:50 INFO - PROCESS | 1641 | 08:30:53 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:30:54 INFO - PROCESS | 1641 | RSS: Main: 339415040 08:30:54 INFO - PROCESS | 1641 | 08:33:56 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:33:57 INFO - PROCESS | 1641 | RSS: Main: 365416448 08:33:57 INFO - PROCESS | 1641 | 08:37:00 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:37:01 INFO - PROCESS | 1641 | RSS: Main: 332754944 08:37:01 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:40:04 INFO - PROCESS | 1641 | RSS: Main: 506806272 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | __start_tp_report 08:40:04 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 08:40:04 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 08:40:04 INFO - PROCESS | 1641 | |i|pagename|runs| 08:40:04 INFO - PROCESS | 1641 | |0;dojo.html;3323.435016047272;3326.2349659578294;3349.8827541036067;3376.6960973512378;3408.744344174186;5601.467860553241;5652.830415087544;5672.546196304296;5721.370649228582;5741.827745167647;3810.695144388449;5271.341082364705;5460.689434535712;5650.830475085743;5769.826905192851;5039.067772462106;5052.166392545226;5068.366454193226;5125.513076257768;5128.923066153992;5138.845834624967;5205.687658740469;5233.398159211702;5244.108501554726;5271.5782737381105;5102.438731739506;5231.973840130813;5245.8950820983555;5247.658902171384;5330.706811125387;5103.744812759347;5145.25393817898;5152.716600586966;5196.45437229093;5200;5127.9743601282125;5168.8449346519665;5181.093308670967;5204.0372531081875;5244.056069907415;5673.149027645845;5688.772449102031;5689.516391106761;5723.484886360247;5753.223314852525;6097.664628445434;6115.362036198677;6123.984276525883;6207.410296021916;6223.719932603044;6146.846328841814;6151.87696246077;6241.687915604201;6280.685965701742;6282.057691346289;5756.33802112754;5761.48146666802;5787;5801.216835727208;5808.4191580842;6079.817605471843;6125.907024958145;6227.252729672377;6238.656873871981;6239.906401403982;5971.164037034819;6024.608400453956;6084.756609735561;6110.050511076634;6135.049067394561;6222.81331560054;6225.221847269091;6233.594816337014;6255.812325630239;6267.0286105653695;6145.692715364214;6164.106204600397;6177.69111544421;6201.627902325875;6203.627782332984;6120.540959428061;6127.938720612826;6129.080637904261;6161.476274516716;6198.752049917953;4902.730349830722;4905.386826646669;4912.336834527293;4919.680220785637;4923.384576927884;3863.787491687984;4365.126974605092;4427.889302767457;4447.488538818013;4465.37484752135;5662;5699.401562835926;5712.028955077647;5757.65454072757;5757.971210144006;6246.094316324107;6257.530685198628;6268.122462855204;6273.811785646438;6280;5777.335606405233;5778.566607504454;5788.160716696056;5789.594728369058;5809.331926828384;5277.630565860353;5331.70675612845;5335.199720041947;5339.919901201485;5399.1091469907815;6219.782307619302;6221.720022598994;6247.2815626202655;6254;6259.12372267892;6244.063390491463;6251.124842522141;6255.530835187288;6260.624362538262;6263.843403914939;6129.725578588854;6163.9383606163365;6171.290301615192;6218.347073557211;6229.3770622937345;6123.4488895999575;6179.196704428396;6188.381161883955;6191.659458729813;6192.752289908353;6226.750929962932;6227.003679411272;6234.75060997555;6237.438630523275;6249.25008998923;5910.881782364243;5940.61386009908;6047.455728984412;6070.7875224366935;6094.878102438015;4989.525995030466;5965.612235204698;5984.820455386345;6070.878582428239;6122.571420000557;5918.585699001029;5929.703514824155;5931.110333449845;5931.673757943355;5955;6027.276726792813;6053.061775424816;6079.878402432015;6083.7870674526175;6106.175666284995;5774.133879918046;5806.158107074366;5821.185034095315;5823.82528524145;5885.941140588539 08:40:04 INFO - PROCESS | 1641 | |1;ext.html;437.407313090762;467.02858055245093;490.9812139809891;495.1261024292125;505.87947695853677;27804;39881.00297492561;41180.58819411805;41380.58619413812;41392.37911431323;35254;42394;42879.571204287946;42916.785416072955;42939.3559096613;8535.359848011392;9394.71815845524;9592.80814383712;9613.615455381776;9619.42283462991;8599.011113721908;11525.942370288138;11790.646280611596;11845.940770296136;11886.881131188664;10283.35466325388;11138.27601205919;11550.711232219177;11652.242604230698;11692.707682307926;11358.31850088989;11459.942700286487;11535.59625413115;11539.826902596467;11541.249818761753;11238.775224495464;11288.661340159808;11362.71593210168;11403.030742386907;11460.54157833694;40322.59677403247;40702.592974070474;40760.18479630391;40775;40832.387514187314;3211.903642890717;3363.697267245935;3376.1559610097474;3423.0757695422344;3533.957482542656;21449.785502144936;23885.402864928343;27285.317867053283;28274.717252827413;28451;3089.3029648146103;3221.532877732739;3254.1864533866533;3284.786488878215;3302.3890580242733;440750;443868;444030;444477;444983;54548.45451545513;54946.90106197853;54956.62608434741;55011.44988550143;55076;46852.7657361711;56515;56615.150772738445;56685.71657141688;56714;15259.313330900137;15431.768523472158;15464.14947177916;15465.381384744484;15499.302531386114;10414.323069000491;11534.19260651763;11564.595239166589;12095.758084838253;12170.878291216974;15072.171030593203;16576.503356784433;20705.27531536389;20909.581808363746;21335.78664213369;7388.371988381048;7503.5873026982945;8101.339225458767;8115.6753729851325;8129.674813007532;888.5201990924958;924.7872989212519;1050.9264351495474;1069.5080263078914;1104.4588151805558;30702.53946190809;30830.60719699994;31157.68842311593;31255;31281.374372512877;976.8632391465201;1037.2842738510403;1049.317943336837;1059.5338051257422;1071.6195750508614;15685;15779.526614201592;15814.288357023961;15827;16176.191190440431;644540;647859;647872;647937;651832;60405.39594603998;61031;61227;61309;61322.69338653278;1033.3180101133366;1238.8637249902504;1355.5120156743565;1386.4038463460809;1389.6595334143199;29936.85031574828;30966.0710178686;31021.534676980315;31647.52528712117;31998.68001319957;51298.97402051863;52990;54445.18332225099;54656.45343546513;54693.453065468835;520372;526339;526719;527399;527405;25418.364540886625;25596.104136355138;26203.082892098686;26739.598906016814;38084.80957595194;43331;43352;43537.56462435335;43638.47265345698;43893.78053109714;35784.642153578134;36034.27931441304;36058.27883442264;36517.81741091277;36878;35814.820925895205;35833.32091535371;36060.45909311415;36653.900382988555;36946.8152659235;28229.576556352084;35020.64979350174;35463.468047978786;35972.28055438929;36137.277254455286;31198.844005779825;31855.36289274248;31953.881614143393;32021.67978320187;32036.67963320337;23285.88357058204;23542.88114069742;24122.517549648557;24180.758192417852;24290.271291861274 08:40:04 INFO - PROCESS | 1641 | |2;jquery.html;312.8467051144939;352.508250989869;357.6441440766436;369.6839202481877;401.33378591538036;11271.887281127196;14995.675670271112;15132.546023619281;15845.92077039616;20174.798252017474;20085;20524.794752052476;20769.792302076974;21153.04811283492;21420;5065.696058236499;6033.366496517846;6036.577439579231;6057.54568407369;6075.33171351151;5500.81732427528;5693.174489698991;5866.6480011199255;5905.29136503618;5908;5768.42315768424;5871.266091738533;5882.911756323659;5882.941170588282;5888.911666325009;5728.856778580548;5765.827025189251;5887.587868849182;5918.852028699274;5938.198343223696;5177.378714554277;5179.171332586768;5180.3265575475325;5182.792688292501;5185.429602743695;27010;27720.584191237147;28205.43589128206;28938;29267.560986585217;2265.716785401825;2462.963055554168;2621.252942911261;2679.2096331582034;3030.727234548879;13435.529756458476;14404.847612190999;16734.74897876533;16891.91554042222;17304.012920859735;1642.523668136251;1869.345728994841;1910.923563057476;1999.240288690303;2034.532057626754;92651.53674231586;122412.04321718971;123479;130563;137896;18804.81195188058;18837.81162188388;19521.707174392395;20276;20903.58192836165;34848.30303393918;34871.51284871493;34975.65024349724;34992.125196869776;35061.649383505835;10341.534630941625;10550.314229575053;10660.987206215397;10790.946045269724;10809.459527023775;8739.257163141077;8753;8806.77983050416;8935.687250946186;8962;9069.86626671666;9548.37935534202;9776.608935642636;9976.80046399068;10000.849902261187;3078.8768449262225;3377.594688637379;3437.8796742113905;3803.1633040730994;3803.695704343646;761.5240474703311;832.7709879783108;882.9955850220837;892.8660601036647;912.6942474271061;16188;17774.46676599704;20141.597168056556;20573.588528229353;21312.04095815692;867.1978419961637;915.2037727177399;917.6008436330218;931.38993958957;939.2392162348519;10699.144068474503;11047.171462140372;11304.434778261055;11417.48621312043;11470.426478676032;465400;529988.9007769496;535172;557505;557681;124147;127285.36357318154;130362;131118.34440827733;137657;950.4154944708954;978.6427953796813;992.8758905136858;1000.9449480278655;1004.4073996342194;13459.730805384033;15960.840391596399;17404.477865664052;18528;19027.619447611247;51906.74046629743;53567;53704;53828;53940.92118157693;74031.6298418526;76443.61778191074;79552.20447795448;79818.6009069951;82192;7897.802554936173;7998.84002319962;8125.4718443301;8142.3486121111355;8233.79415514617;7653.234676532302;9971.504274358904;10462;12616.243025418504;13474.19154850712;10083.14293285079;11145.219834611824;11554.59558915434;11655.59205427806;11930.582429614922;11132.38771867555;11162.55349786032;11514.481848316678;11530.654080377602;11680.70798230051;11227.38249396291;11497.425128743696;11766.58816941403;11829.585964491202;11891.82162267584;6999.09011828459;7322.926770732438;7345.375643070185;7534.736284230025;8344.58277086131;9788.706338809847;10868.836967445653;11577.7105572358;11618.244814087057;11766.647000589996 08:40:04 INFO - PROCESS | 1641 | |3;mootools.html;1463.6633574277917;1493.9178345191015;1697.6774412861555;1859.2934684819766;1886.6509695706304;8009.87985180222;8429.325653947684;8431.789205269855;8441;8450;7439.181690014094;7677;8008.559529225905;8208.056073551543;8254.834903301931;2299.287220961499;2342.1568235435316;2344.9648255276184;2347.812175025994;2350.177437896731;2341.8711970841596;2359.1860808021206;2371.1226846066893;2372.2171683344454;2374.95250094998;2312.2947501012186;2320.7447180810095;2342.4612339162004;2342.917997870075;2351.200591798788;2269.239804665439;2285.5086156476436;2290.450291929933;2321.373229228099;2327.4181454636428;2190.671399290103;2221.1892659179284;2230.565039817236;2240.003198576634;2320.97679023211;7349.412047036224;8299.543525106117;8398.454100483448;8400.285975692073;8409.327253819742;4928.088303663833;5150.871228219287;5151.459096794858;5160.767765450564;5161.329027226474;3010.458117538842;3213.8714451422147;3370.1911541230174;3580.158662714286;3582.910427239314;1015.137133436573;1031.8761748590143;1059.0309866472169;1069.12331887852;1075.2580719303655;10292;10669.253152279343;10687.946560267148;10695.304805187638;10857.3485590864;4263.637590804754;4327.156204540084;4433.46798384196;4452.106131014802;4481.215787237221;8567.27178189861;8615.827683446421;8623.870641940375;8639.870401943976;8668.219860212612;4973.477784832613;5063.924041139386;5064.417591976896;5069.087564238473;5076.923846142311;3833.597472265372;4202.831886724558;4701.858944231679;4730.2431610942085;4775.140474714584;3607.8917632471066;3630.2920930418845;3675.61406052366;3694.2057457646197;3694.630536946284;1123.4214379594516;1129.1757017377197;1132.7224829916722;1143.4625725908809;1147.5983405807901;865.7749284761991;871.3943809052647;880.097899652861;902.5442151713343;938.6808485115093;4810.4467986181335;5532.150942264737;5602.179291730204;5813.157092221604;6061.866492367019;875.6803766625136;884.7088829554049;915.5330781301584;916.5188276155072;932.9440233586007;3437.845296961643;3633.6184700606586;3852.3836186210074;3907.941380879289;4027.9798601006805;9660.71017869465;9995.20038396941;10002.549885255035;10034.147097496649;10066.748331291776;9748.26887983404;9844.310898237054;9918.305718599773;9974.152197063331;10001.899981000097;7069.505134640526;7687.884681729778;7863.488873223222;7877.487963282254;7897.644605992744;5439.292891924025;5690;5729.369769325454;5775.942240577709;5784.768609255582;9124.863127052966;9217.078292170729;9290.16388525036;9375.765605859908;9399.906000939904;7286.635668216462;9438.95280523593;9441.669541566012;9544.809103818023;9564.856527152237;6606.6036037837885;6834.794956151323;6841.657917104026;7110.217876033736;7314.37827784623;6911.308869113049;7426.777196684108;7477.401807855467;7583.696652133853;7599.88600171009;6633.734650614115;6714.83212919681;6767.526273160832;6798.354156355138;6877.2091209509545;6665.333466653296;6679.131712877295;6698;6735.191776986597;6747.359000894907;6319.6208227506495;6333.36666333363;6334.619922804646;6340.778072767431;6400.967995159995;4603.884902877455;4632.745199014086;4638.744869032235;4707.81168753246;4709.175894218567;4690.296455531561;4691.812327506861;4711.764411779329;4738.881527961691;4740.288956656529 08:40:04 INFO - PROCESS | 1641 | |4;prototype.html;345.2542508182326;348.07933017169586;354.4700672494619;370.4350864930978;374.2963229129238;4302.354646802981;4941.82703605373;5203.921941170881;5219.86950326242;5220.817271395502;4412.42638457001;4565.269556870901;5098.9745051274695;5190.342526645955;5206.401263854658;3788.4467368379037;3795.924081518368;4088.3458646616546;4108.178364327132;4115.609017143366;3820.331441997653;4118.752874827505;4142.9378559321485;4161.066448154044;4162.313218318974;3221.4523530999786;4040.1111755413763;4044.7370920890194;4083.2650122977852;4097.508299004124;3761.9059523511855;4045.939310910339;4072.9635182408647;4077.2660921034203;4096.160287141129;3627.310810945938;3652.3425783358985;3653.378925582631;3663.1940972986167;3674.1365779041903;4113.25961326961;4231.640310573605;4759;5067.417247016603;5079.79680812767;4076.1440097579543;4185.393117997904;4507.985703216783;4666.9766651166865;4681.32120842476;4376.431063961696;5463.945360546423;5495.0383682855345;5523.917141242885;5525.889482210374;3665.6700896919406;3681.374166391693;3750.287445385368;3862;3959.3862951242604;5081.644284900059;5495.697736624484;5770.336411312669;5806.65160090396;5807.622504537234;4110.630043296118;4125.463689720377;4132.752034877917;4134.545200027995;4163.084121493267;3866.903327416781;4206.642435392964;4222.071144348239;4222.915541689149;4251.59609837065;4345;4392.1874453226255;4485.663575231871;4610.9308360374625;4700.647451441156;4690.64820138491;5520.641158324696;5522.861928451821;5582.9572882778175;5610.326760788732;1117.0337657925998;1304.9151805132635;1313.343328335832;1333.1534475607864;1374.6494643865951;871.5706241763513;892.9598168082451;913.899471058183;962.4177372689422;979.1970584120952;4087.4481944937647;4202.957970420318;4407.201427093819;4678.1813182692895;4890.483949975448;5027.79888804451;5281.069006701317;5413.675179489243;5427.43011983744;5465.453454654582;4777.378940737752;5161.329027226437;5219.52072765441;5253.395859476209;5284.365876094893;2424.9209101949814;2548.6686730724887;2615.882285297166;2867.211516832888;2869.512182928907;4976.377952755905;5260.106941182335;5333.466653334713;5354.330708661418;5592.384837667853;4802.759862006886;5297.973510132425;5431.94077154951;5521.806736764194;5556.91664625031;4869.394873742602;5451.400345961941;5540.36285827127;5552.361478430033;5558.304222452108;4408.404865343137;5003.323643507024;5356.812511562077;5367.758450869798;5390;4581.6325001124815;4699.718016918996;5341.4925582069645;5350.919736203882;5353.705546194841;4804.051826618588;4963.454020057863;5134.922976155435;5317.361916570037;5584.274044374205;3473.3949537846615;3556.7510274281585;3784.0350710568628;3822.503074600284;3833.5783063862395;5586.742982828831;5588.497035266845;5607.691576963306;5615.438456154352;5636.2954630671165;4733.431988161443;5233.39815921174;5485.32697527258;5512.200730893917;5526.50784288248;5230.077441918561;5279.630425870152;5425.321834770653;5441.918371224356;5473.31583552056;5134.383873935151;5233.869153271199;5274.287971123849;5276.261323414648;5338.731039308201;4640;5505.697186654773;5515.586331025109;5527.419620939904;5544.750486228048;4250;4816.301636262792;5144.871378215575;5286.101362768415;5380.354357477127 08:40:04 INFO - PROCESS | 1641 | |5;yui.html;586.6362855029882;732.6629750314852;744.6686224630042;781.9061712594489;827.8716798896173;14720.263986800657;15202.315895784688;15608.921955390208;15713.292901819432;15846.603834904134;14022.719545609081;14296.71406571868;14426.495072672433;14585;14611.78082328766;854.9187827156426;874.1302404107889;883.2845395229853;884.2969838977996;887.40100432208;690.4441924251001;711.2887112887113;711.4628455516104;876.6537217798966;878.9121087891224;896.8789213456165;926.3469254175824;927.3045216087934;928.4104593583089;928.6424726480286;882.161946151159;905.6332185464897;908.7500937242245;932.6409332407038;934.8270569944582;533.8345113014939;695.600029982762;696.4915611603558;698.3261152987392;699.5557820783788;12246.632601021984;14399.352029158714;14977.550673479813;15013.324400402009;15016.324265408082;13503.66240843977;13582.456701731919;13618.387172577257;13954.51159209433;14008.789868151986;12951.67620809478;13014.349282535835;13060.151090179108;13116.737665246641;13134.671633209151;4422;4423.557644235583;4474.194644963905;4560.589546940758;4677.579017888406;113163.43418282855;114066;115550.42224788906;115968.42015789951;116819.82261241716;10808.51361688726;11149.609763658395;11192;11201.495932683049;11243;22940.655890161328;23812.285631431085;23812.761872381056;23824.047038118282;23876;8061.596920153969;8062.355011599176;8101.959490202511;8128.065272493621;8254.504729716236;4208.242516347026;4236.131593023423;4332.4801023877335;4427.22523558376;4436.933445998313;3596.82015899204;3647.4893514907935;3713.294474049922;3719.1817800083936;3720.8511659533315;656.1921905151278;662.2814246542459;669.1668872253978;683.8256244657581;691.629977961788;527.8020742221667;592.5881512348963;645.6513482719279;662.3442791636342;673.3300366135726;9000.36997410175;9002.50486223264;9084.364094513321;9408.482533460725;9551.665691700757;605.9163617251265;626.4737620398887;645.7223393940651;655.4101308822003;690.7375197425047;3644.1436262478296;4195.58044195578;4411.250087485135;4472.776361181928;4516.638668906479;85884;87194;95657.04342956482;98555;102683.45974810384;68830.65584672145;87474.56262718773;88431;88853;89290;77779.22220777832;78619.4276114486;78687.99999999885;78859;80064.59967700124;7810.960945195237;9783.168430683472;9796.46119463408;9887;9957.800843983225;48507.757461212466;48714.51285487242;50381.24428133508;50399.24401133913;50976;57832.71083644555;70647.29352706407;72460.55078898498;72561.91157132541;74474.13814654677;12991.949241313458;13103.672408189872;13109.410076546768;13370.866291337352;13559.118657287245;14412.927935360256;14675.853241467876;14708.77936830927;14895.404183832525;14934.253287335372;13686.589402317946;13722.108062975874;13889.791653125008;14401.135931844123;14483.565493035227;13382.598522044354;13631.727365452834;13776.380062897395;13937.233452160228;14237.21695306768;13378.866211337761;13670.17978921268;13811.792823107862;13852;14169.22069286199;10185.796284074426;10261.58953641846;10461.633842815465;10502.527386267484;10742.194335424718;8288.668453261802;10398.376097434179;10725.678229653124;10769.62306319275;10778.353298802096 08:40:04 INFO - PROCESS | 1641 | __end_tp_report 08:40:04 INFO - PROCESS | 1641 | __start_cc_report 08:40:04 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1579 08:40:04 INFO - PROCESS | 1641 | __end_cc_report 08:40:04 INFO - PROCESS | 1641 | __startTimestamp1481647204838__endTimestamp 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | ------- Summary: start ------- 08:40:04 INFO - PROCESS | 1641 | Number of tests: 6 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5693.06 Median:5918.59 stddev:656.90 (11.1%) stddev-sans-first:632.07 08:40:04 INFO - PROCESS | 1641 | Values: 3323.4 3326.2 3349.9 3376.7 3408.7 5601.5 5652.8 5672.5 5721.4 5741.8 3810.7 5271.3 5460.7 5650.8 5769.8 5039.1 5052.2 5068.4 5125.5 5128.9 5138.8 5205.7 5233.4 5244.1 5271.6 5102.4 5232.0 5245.9 5247.7 5330.7 5103.7 5145.3 5152.7 5196.5 5200.0 5128.0 5168.8 5181.1 5204.0 5244.1 5673.1 5688.8 5689.5 5723.5 5753.2 6097.7 6115.4 6124.0 6207.4 6223.7 6146.8 6151.9 6241.7 6280.7 6282.1 5756.3 5761.5 5787.0 5801.2 5808.4 6079.8 6125.9 6227.3 6238.7 6239.9 5971.2 6024.6 6084.8 6110.1 6135.0 6222.8 6225.2 6233.6 6255.8 6267.0 6145.7 6164.1 6177.7 6201.6 6203.6 6120.5 6127.9 6129.1 6161.5 6198.8 4902.7 4905.4 4912.3 4919.7 4923.4 3863.8 4365.1 4427.9 4447.5 4465.4 5662.0 5699.4 5712.0 5757.7 5758.0 6246.1 6257.5 6268.1 6273.8 6280.0 5777.3 5778.6 5788.2 5789.6 5809.3 5277.6 5331.7 5335.2 5339.9 5399.1 6219.8 6221.7 6247.3 6254.0 6259.1 6244.1 6251.1 6255.5 6260.6 6263.8 6129.7 6163.9 6171.3 6218.3 6229.4 6123.4 6179.2 6188.4 6191.7 6192.8 6226.8 6227.0 6234.8 6237.4 6249.3 5910.9 5940.6 6047.5 6070.8 6094.9 4989.5 5965.6 5984.8 6070.9 6122.6 5918.6 5929.7 5931.1 5931.7 5955.0 6027.3 6053.1 6079.9 6083.8 6106.2 5774.1 5806.2 5821.2 5823.8 5885.9 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:67188.64 Median:19221.86 stddev:145741.17 (758.2%) stddev-sans-first:146063.84 08:40:04 INFO - PROCESS | 1641 | Values: 437.4 467.0 491.0 495.1 505.9 27804.0 39881.0 41180.6 41380.6 41392.4 35254.0 42394.0 42879.6 42916.8 42939.4 8535.4 9394.7 9592.8 9613.6 9619.4 8599.0 11525.9 11790.6 11845.9 11886.9 10283.4 11138.3 11550.7 11652.2 11692.7 11358.3 11459.9 11535.6 11539.8 11541.2 11238.8 11288.7 11362.7 11403.0 11460.5 40322.6 40702.6 40760.2 40775.0 40832.4 3211.9 3363.7 3376.2 3423.1 3534.0 21449.8 23885.4 27285.3 28274.7 28451.0 3089.3 3221.5 3254.2 3284.8 3302.4 440750.0 443868.0 444030.0 444477.0 444983.0 54548.5 54946.9 54956.6 55011.4 55076.0 46852.8 56515.0 56615.2 56685.7 56714.0 15259.3 15431.8 15464.1 15465.4 15499.3 10414.3 11534.2 11564.6 12095.8 12170.9 15072.2 16576.5 20705.3 20909.6 21335.8 7388.4 7503.6 8101.3 8115.7 8129.7 888.5 924.8 1050.9 1069.5 1104.5 30702.5 30830.6 31157.7 31255.0 31281.4 976.9 1037.3 1049.3 1059.5 1071.6 15685.0 15779.5 15814.3 15827.0 16176.2 644540.0 647859.0 647872.0 647937.0 651832.0 60405.4 61031.0 61227.0 61309.0 61322.7 1033.3 1238.9 1355.5 1386.4 1389.7 29936.9 30966.1 31021.5 31647.5 31998.7 51299.0 52990.0 54445.2 54656.5 54693.5 520372.0 526339.0 526719.0 527399.0 527405.0 25418.4 25596.1 26203.1 26739.6 38084.8 43331.0 43352.0 43537.6 43638.5 43893.8 35784.6 36034.3 36058.3 36517.8 36878.0 35814.8 35833.3 36060.5 36653.9 36946.8 28229.6 35020.6 35463.5 35972.3 36137.3 31198.8 31855.4 31953.9 32021.7 32036.7 23285.9 23542.9 24122.5 24180.8 24290.3 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34312.40 Median:1845.22 stddev:89231.56 (4835.8%) stddev-sans-first:89445.36 08:40:04 INFO - PROCESS | 1641 | Values: 312.8 352.5 357.6 369.7 401.3 11271.9 14995.7 15132.5 15845.9 20174.8 20085.0 20524.8 20769.8 21153.0 21420.0 5065.7 6033.4 6036.6 6057.5 6075.3 5500.8 5693.2 5866.6 5905.3 5908.0 5768.4 5871.3 5882.9 5882.9 5888.9 5728.9 5765.8 5887.6 5918.9 5938.2 5177.4 5179.2 5180.3 5182.8 5185.4 27010.0 27720.6 28205.4 28938.0 29267.6 2265.7 2463.0 2621.3 2679.2 3030.7 13435.5 14404.8 16734.7 16891.9 17304.0 1642.5 1869.3 1910.9 1999.2 2034.5 92651.5 122412.0 123479.0 130563.0 137896.0 18804.8 18837.8 19521.7 20276.0 20903.6 34848.3 34871.5 34975.7 34992.1 35061.6 10341.5 10550.3 10661.0 10790.9 10809.5 8739.3 8753.0 8806.8 8935.7 8962.0 9069.9 9548.4 9776.6 9976.8 10000.8 3078.9 3377.6 3437.9 3803.2 3803.7 761.5 832.8 883.0 892.9 912.7 16188.0 17774.5 20141.6 20573.6 21312.0 867.2 915.2 917.6 931.4 939.2 10699.1 11047.2 11304.4 11417.5 11470.4 465400.0 529988.9 535172.0 557505.0 557681.0 124147.0 127285.4 130362.0 131118.3 137657.0 950.4 978.6 992.9 1000.9 1004.4 13459.7 15960.8 17404.5 18528.0 19027.6 51906.7 53567.0 53704.0 53828.0 53940.9 74031.6 76443.6 79552.2 79818.6 82192.0 7897.8 7998.8 8125.5 8142.3 8233.8 7653.2 9971.5 10462.0 12616.2 13474.2 10083.1 11145.2 11554.6 11655.6 11930.6 11132.4 11162.6 11514.5 11530.7 11680.7 11227.4 11497.4 11766.6 11829.6 11891.8 6999.1 7322.9 7345.4 7534.7 8344.6 9788.7 10868.8 11577.7 11618.2 11766.6 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5315.62 Median:5113.90 stddev:2893.79 (56.6%) stddev-sans-first:2887.43 08:40:04 INFO - PROCESS | 1641 | Values: 1463.7 1493.9 1697.7 1859.3 1886.7 8009.9 8429.3 8431.8 8441.0 8450.0 7439.2 7677.0 8008.6 8208.1 8254.8 2299.3 2342.2 2345.0 2347.8 2350.2 2341.9 2359.2 2371.1 2372.2 2375.0 2312.3 2320.7 2342.5 2342.9 2351.2 2269.2 2285.5 2290.5 2321.4 2327.4 2190.7 2221.2 2230.6 2240.0 2321.0 7349.4 8299.5 8398.5 8400.3 8409.3 4928.1 5150.9 5151.5 5160.8 5161.3 3010.5 3213.9 3370.2 3580.2 3582.9 1015.1 1031.9 1059.0 1069.1 1075.3 10292.0 10669.3 10687.9 10695.3 10857.3 4263.6 4327.2 4433.5 4452.1 4481.2 8567.3 8615.8 8623.9 8639.9 8668.2 4973.5 5063.9 5064.4 5069.1 5076.9 3833.6 4202.8 4701.9 4730.2 4775.1 3607.9 3630.3 3675.6 3694.2 3694.6 1123.4 1129.2 1132.7 1143.5 1147.6 865.8 871.4 880.1 902.5 938.7 4810.4 5532.2 5602.2 5813.2 6061.9 875.7 884.7 915.5 916.5 932.9 3437.8 3633.6 3852.4 3907.9 4028.0 9660.7 9995.2 10002.5 10034.1 10066.7 9748.3 9844.3 9918.3 9974.2 10001.9 7069.5 7687.9 7863.5 7877.5 7897.6 5439.3 5690.0 5729.4 5775.9 5784.8 9124.9 9217.1 9290.2 9375.8 9399.9 7286.6 9439.0 9441.7 9544.8 9564.9 6606.6 6834.8 6841.7 7110.2 7314.4 6911.3 7426.8 7477.4 7583.7 7599.9 6633.7 6714.8 6767.5 6798.4 6877.2 6665.3 6679.1 6698.0 6735.2 6747.4 6319.6 6333.4 6334.6 6340.8 6401.0 4603.9 4632.7 4638.7 4707.8 4709.2 4690.3 4691.8 4711.8 4738.9 4740.3 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4401.34 Median:4810.18 stddev:1296.00 (26.9%) stddev-sans-first:1263.37 08:40:04 INFO - PROCESS | 1641 | Values: 345.3 348.1 354.5 370.4 374.3 4302.4 4941.8 5203.9 5219.9 5220.8 4412.4 4565.3 5099.0 5190.3 5206.4 3788.4 3795.9 4088.3 4108.2 4115.6 3820.3 4118.8 4142.9 4161.1 4162.3 3221.5 4040.1 4044.7 4083.3 4097.5 3761.9 4045.9 4073.0 4077.3 4096.2 3627.3 3652.3 3653.4 3663.2 3674.1 4113.3 4231.6 4759.0 5067.4 5079.8 4076.1 4185.4 4508.0 4667.0 4681.3 4376.4 5463.9 5495.0 5523.9 5525.9 3665.7 3681.4 3750.3 3862.0 3959.4 5081.6 5495.7 5770.3 5806.7 5807.6 4110.6 4125.5 4132.8 4134.5 4163.1 3866.9 4206.6 4222.1 4222.9 4251.6 4345.0 4392.2 4485.7 4610.9 4700.6 4690.6 5520.6 5522.9 5583.0 5610.3 1117.0 1304.9 1313.3 1333.2 1374.6 871.6 893.0 913.9 962.4 979.2 4087.4 4203.0 4407.2 4678.2 4890.5 5027.8 5281.1 5413.7 5427.4 5465.5 4777.4 5161.3 5219.5 5253.4 5284.4 2424.9 2548.7 2615.9 2867.2 2869.5 4976.4 5260.1 5333.5 5354.3 5592.4 4802.8 5298.0 5431.9 5521.8 5556.9 4869.4 5451.4 5540.4 5552.4 5558.3 4408.4 5003.3 5356.8 5367.8 5390.0 4581.6 4699.7 5341.5 5350.9 5353.7 4804.1 4963.5 5134.9 5317.4 5584.3 3473.4 3556.8 3784.0 3822.5 3833.6 5586.7 5588.5 5607.7 5615.4 5636.3 4733.4 5233.4 5485.3 5512.2 5526.5 5230.1 5279.6 5425.3 5441.9 5473.3 5134.4 5233.9 5274.3 5276.3 5338.7 4640.0 5505.7 5515.6 5527.4 5544.8 4250.0 4816.3 5144.9 5286.1 5380.4 08:40:04 INFO - PROCESS | 1641 | 08:40:04 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20503.48 Median:4473.49 stddev:29414.87 (657.5%) stddev-sans-first:29459.37 08:40:04 INFO - PROCESS | 1641 | Values: 586.6 732.7 744.7 781.9 827.9 14720.3 15202.3 15608.9 15713.3 15846.6 14022.7 14296.7 14426.5 14585.0 14611.8 854.9 874.1 883.3 884.3 887.4 690.4 711.3 711.5 876.7 878.9 896.9 926.3 927.3 928.4 928.6 882.2 905.6 908.8 932.6 934.8 533.8 695.6 696.5 698.3 699.6 12246.6 14399.4 14977.6 15013.3 15016.3 13503.7 13582.5 13618.4 13954.5 14008.8 12951.7 13014.3 13060.2 13116.7 13134.7 4422.0 4423.6 4474.2 4560.6 4677.6 113163.4 114066.0 115550.4 115968.4 116819.8 10808.5 11149.6 11192.0 11201.5 11243.0 22940.7 23812.3 23812.8 23824.0 23876.0 8061.6 8062.4 8102.0 8128.1 8254.5 4208.2 4236.1 4332.5 4427.2 4436.9 3596.8 3647.5 3713.3 3719.2 3720.9 656.2 662.3 669.2 683.8 691.6 527.8 592.6 645.7 662.3 673.3 9000.4 9002.5 9084.4 9408.5 9551.7 605.9 626.5 645.7 655.4 690.7 3644.1 4195.6 4411.3 4472.8 4516.6 85884.0 87194.0 95657.0 98555.0 102683.5 68830.7 87474.6 88431.0 88853.0 89290.0 77779.2 78619.4 78688.0 78859.0 80064.6 7811.0 9783.2 9796.5 9887.0 9957.8 48507.8 48714.5 50381.2 50399.2 50976.0 57832.7 70647.3 72460.6 72561.9 74474.1 12991.9 13103.7 13109.4 13370.9 13559.1 14412.9 14675.9 14708.8 14895.4 14934.3 13686.6 13722.1 13889.8 14401.1 14483.6 13382.6 13631.7 13776.4 13937.2 14237.2 13378.9 13670.2 13811.8 13852.0 14169.2 10185.8 10261.6 10461.6 10502.5 10742.2 8288.7 10398.4 10725.7 10769.6 10778.4 08:40:04 INFO - PROCESS | 1641 | -------- Summary: end -------- 08:40:04 INFO - PROCESS | 1641 | 08:40:05 INFO - TEST-INFO | 1641: exit 0 08:40:05 INFO - TEST-OK | dromaeo_css | took 1119793ms 08:40:05 INFO - TEST-START | kraken 08:40:05 INFO - operating with platform_type : mac_ 08:40:05 INFO - Initialising browser for kraken test... 08:40:05 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpPOoAZb/profile http://localhost:49241/getInfo.html) 08:40:07 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 08:40:07 INFO - PROCESS | 1651 | colorDepth:24 08:40:07 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 08:40:07 INFO - PROCESS | 1651 | __metrics 08:40:07 INFO - PROCESS | 1651 | 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" 08:40:07 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:40:08 INFO - TEST-INFO | 1651: exit 0 08:40:08 INFO - Browser initialized. 08:40:08 INFO - Running cycle 1/1 for kraken test... 08:40:08 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpPOoAZb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:20 INFO - PROCESS | 1652 | RSS: Main: 237211648 08:40:20 INFO - PROCESS | 1652 | 08:40:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:24 INFO - PROCESS | 1652 | RSS: Main: 288808960 08:40:24 INFO - PROCESS | 1652 | 08:40:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:40:27 INFO - PROCESS | 1652 | RSS: Main: 289832960 08:40:27 INFO - PROCESS | 1652 | 08:40:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:40:31 INFO - PROCESS | 1652 | RSS: Main: 380907520 08:40:31 INFO - PROCESS | 1652 | 08:40:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:40:33 INFO - PROCESS | 1652 | RSS: Main: 283615232 08:40:33 INFO - PROCESS | 1652 | 08:40:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:36 INFO - PROCESS | 1652 | RSS: Main: 287145984 08:40:36 INFO - PROCESS | 1652 | 08:40:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:40 INFO - PROCESS | 1652 | RSS: Main: 328859648 08:40:40 INFO - PROCESS | 1652 | 08:40:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:43 INFO - PROCESS | 1652 | RSS: Main: 331788288 08:40:43 INFO - PROCESS | 1652 | 08:40:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:40:47 INFO - PROCESS | 1652 | RSS: Main: 329052160 08:40:47 INFO - PROCESS | 1652 | 08:40:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:49 INFO - PROCESS | 1652 | RSS: Main: 305016832 08:40:49 INFO - PROCESS | 1652 | 08:40:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:52 INFO - PROCESS | 1652 | RSS: Main: 308137984 08:40:52 INFO - PROCESS | 1652 | 08:40:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:54 INFO - PROCESS | 1652 | RSS: Main: 308682752 08:40:54 INFO - PROCESS | 1652 | 08:40:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:58 INFO - PROCESS | 1652 | RSS: Main: 327856128 08:40:58 INFO - PROCESS | 1652 | 08:41:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:02 INFO - PROCESS | 1652 | RSS: Main: 321736704 08:41:02 INFO - PROCESS | 1652 | 08:41:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:41:04 INFO - PROCESS | 1652 | RSS: Main: 365666304 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | __start_tp_report 08:41:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 08:41:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 08:41:04 INFO - PROCESS | 1652 | |i|pagename|runs| 08:41:04 INFO - PROCESS | 1652 | |0;ai-astar;113;112;114;113;113;112;113;113;113;112 08:41:04 INFO - PROCESS | 1652 | |1;audio-beat-detection;151;113;102;162;144;152;114;115;135;115 08:41:04 INFO - PROCESS | 1652 | |2;audio-dft;183;183;182;183;184;183;179;183;184;183 08:41:04 INFO - PROCESS | 1652 | |3;audio-fft;79;58;60;87;60;62;59;60;74;58 08:41:04 INFO - PROCESS | 1652 | |4;audio-oscillator;91;70;87;69;70;68;83;69;69;84 08:41:04 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;105;108;106;108;107;108;106;108;105;111 08:41:04 INFO - PROCESS | 1652 | |6;imaging-darkroom;92;93;92;93;93;92;94;93;103;149 08:41:04 INFO - PROCESS | 1652 | |7;imaging-desaturate;88;88;87;88;102;131;131;85;85;84 08:41:04 INFO - PROCESS | 1652 | |8;json-parse-financial;56;56;54;53;55;56;55;55;57;55 08:41:04 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;68;72;69;82;74;70;71;70;70;73 08:41:04 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;89;88;87;88;88;89;90;88;89;90 08:41:04 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;149;161;147;148;147;161;148;146;199;162 08:41:04 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;178;179;179;177;177;176;174;176;176;179 08:41:04 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;82;81;83;83;68;67;67;68;67;68 08:41:04 INFO - PROCESS | 1652 | __end_tp_report 08:41:04 INFO - PROCESS | 1652 | __start_cc_report 08:41:04 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1979 08:41:04 INFO - PROCESS | 1652 | __end_cc_report 08:41:04 INFO - PROCESS | 1652 | __startTimestamp1481647264235__endTimestamp 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | ------- Summary: start ------- 08:41:04 INFO - PROCESS | 1652 | Number of tests: 14 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 08:41:04 INFO - PROCESS | 1652 | Values: 113.0 112.0 114.0 113.0 113.0 112.0 113.0 113.0 113.0 112.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:139.50 stddev:20.94 (15.0%) stddev-sans-first:20.83 08:41:04 INFO - PROCESS | 1652 | Values: 151.0 113.0 102.0 162.0 144.0 152.0 114.0 115.0 135.0 115.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.42 (0.8%) stddev-sans-first:1.50 08:41:04 INFO - PROCESS | 1652 | Values: 183.0 183.0 182.0 183.0 184.0 183.0 179.0 183.0 184.0 183.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.70 Median:61.00 stddev:10.40 (17.1%) stddev-sans-first:9.86 08:41:04 INFO - PROCESS | 1652 | Values: 79.0 58.0 60.0 87.0 60.0 62.0 59.0 60.0 74.0 58.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:76.50 stddev:9.08 (11.9%) stddev-sans-first:7.84 08:41:04 INFO - PROCESS | 1652 | Values: 91.0 70.0 87.0 69.0 70.0 68.0 83.0 69.0 69.0 84.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:107.20 Median:108.00 stddev:1.81 (1.7%) stddev-sans-first:1.74 08:41:04 INFO - PROCESS | 1652 | Values: 105.0 108.0 106.0 108.0 107.0 108.0 106.0 108.0 105.0 111.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:93.00 stddev:17.73 (19.1%) stddev-sans-first:18.61 08:41:04 INFO - PROCESS | 1652 | Values: 92.0 93.0 92.0 93.0 93.0 92.0 94.0 93.0 103.0 149.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:86.00 stddev:18.67 (21.7%) stddev-sans-first:19.52 08:41:04 INFO - PROCESS | 1652 | Values: 88.0 88.0 87.0 88.0 102.0 131.0 131.0 85.0 85.0 84.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.14 (2.0%) stddev-sans-first:1.17 08:41:04 INFO - PROCESS | 1652 | Values: 56.0 56.0 54.0 53.0 55.0 56.0 55.0 55.0 57.0 55.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.50 stddev:3.98 (5.6%) stddev-sans-first:3.97 08:41:04 INFO - PROCESS | 1652 | Values: 68.0 72.0 69.0 82.0 74.0 70.0 71.0 70.0 70.0 73.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:89.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 08:41:04 INFO - PROCESS | 1652 | Values: 89.0 88.0 87.0 88.0 88.0 89.0 90.0 88.0 89.0 90.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:155.00 stddev:16.22 (10.5%) stddev-sans-first:16.96 08:41:04 INFO - PROCESS | 1652 | Values: 149.0 161.0 147.0 148.0 147.0 161.0 148.0 146.0 199.0 162.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:177.50 stddev:1.66 (0.9%) stddev-sans-first:1.73 08:41:04 INFO - PROCESS | 1652 | Values: 178.0 179.0 179.0 177.0 177.0 176.0 174.0 176.0 176.0 179.0 08:41:04 INFO - PROCESS | 1652 | 08:41:04 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.50 stddev:7.65 (10.3%) stddev-sans-first:7.45 08:41:04 INFO - PROCESS | 1652 | Values: 82.0 81.0 83.0 83.0 68.0 67.0 67.0 68.0 67.0 68.0 08:41:04 INFO - PROCESS | 1652 | -------- Summary: end -------- 08:41:04 INFO - PROCESS | 1652 | 08:41:05 INFO - TEST-INFO | 1652: exit 0 08:41:05 INFO - TEST-OK | kraken | took 59755ms 08:41:05 INFO - SUITE-END | took 1179s 08:41:05 INFO - Completed test suite (00:19:39) 08:41:05 INFO - javascript benchmark 08:41:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.435016047272, 3326.2349659578294, 3349.8827541036067, 3376.6960973512378, 3408.744344174186, 5601.467860553241, 5652.830415087544, 5672.546196304296, 5721.370649228582, 5741.827745167647, 3810.695144388449, 5271.341082364705, 5460.689434535712, 5650.830475085743, 5769.826905192851, 5039.067772462106, 5052.166392545226, 5068.366454193226, 5125.513076257768, 5128.923066153992, 5138.845834624967, 5205.687658740469, 5233.398159211702, 5244.108501554726, 5271.5782737381105, 5102.438731739506, 5231.973840130813, 5245.8950820983555, 5247.658902171384, 5330.706811125387, 5103.744812759347, 5145.25393817898, 5152.716600586966, 5196.45437229093, 5200.0, 5127.9743601282125, 5168.8449346519665, 5181.093308670967, 5204.0372531081875, 5244.056069907415, 5673.149027645845, 5688.772449102031, 5689.516391106761, 5723.484886360247, 5753.223314852525, 6097.664628445434, 6115.362036198677, 6123.984276525883, 6207.410296021916, 6223.719932603044, 6146.846328841814, 6151.87696246077, 6241.687915604201, 6280.685965701742, 6282.057691346289, 5756.33802112754, 5761.48146666802, 5787.0, 5801.216835727208, 5808.4191580842, 6079.817605471843, 6125.907024958145, 6227.252729672377, 6238.656873871981, 6239.906401403982, 5971.164037034819, 6024.608400453956, 6084.756609735561, 6110.050511076634, 6135.049067394561, 6222.81331560054, 6225.221847269091, 6233.594816337014, 6255.812325630239, 6267.0286105653695, 6145.692715364214, 6164.106204600397, 6177.69111544421, 6201.627902325875, 6203.627782332984, 6120.540959428061, 6127.938720612826, 6129.080637904261, 6161.476274516716, 6198.752049917953, 4902.730349830722, 4905.386826646669, 4912.336834527293, 4919.680220785637, 4923.384576927884, 3863.787491687984, 4365.126974605092, 4427.889302767457, 4447.488538818013, 4465.37484752135, 5662.0, 5699.401562835926, 5712.028955077647, 5757.65454072757, 5757.971210144006, 6246.094316324107, 6257.530685198628, 6268.122462855204, 6273.811785646438, 6280.0, 5777.335606405233, 5778.566607504454, 5788.160716696056, 5789.594728369058, 5809.331926828384, 5277.630565860353, 5331.70675612845, 5335.199720041947, 5339.919901201485, 5399.1091469907815, 6219.782307619302, 6221.720022598994, 6247.2815626202655, 6254.0, 6259.12372267892, 6244.063390491463, 6251.124842522141, 6255.530835187288, 6260.624362538262, 6263.843403914939, 6129.725578588854, 6163.9383606163365, 6171.290301615192, 6218.347073557211, 6229.3770622937345, 6123.4488895999575, 6179.196704428396, 6188.381161883955, 6191.659458729813, 6192.752289908353, 6226.750929962932, 6227.003679411272, 6234.75060997555, 6237.438630523275, 6249.25008998923, 5910.881782364243, 5940.61386009908, 6047.455728984412, 6070.7875224366935, 6094.878102438015, 4989.525995030466, 5965.612235204698, 5984.820455386345, 6070.878582428239, 6122.571420000557, 5918.585699001029, 5929.703514824155, 5931.110333449845, 5931.673757943355, 5955.0, 6027.276726792813, 6053.061775424816, 6079.878402432015, 6083.7870674526175, 6106.175666284995, 5774.133879918046, 5806.158107074366, 5821.185034095315, 5823.82528524145, 5885.941140588539], "value": 5650.89514578322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.407313090762, 467.02858055245093, 490.9812139809891, 495.1261024292125, 505.87947695853677, 27804.0, 39881.00297492561, 41180.58819411805, 41380.58619413812, 41392.37911431323, 35254.0, 42394.0, 42879.571204287946, 42916.785416072955, 42939.3559096613, 8535.359848011392, 9394.71815845524, 9592.80814383712, 9613.615455381776, 9619.42283462991, 8599.011113721908, 11525.942370288138, 11790.646280611596, 11845.940770296136, 11886.881131188664, 10283.35466325388, 11138.27601205919, 11550.711232219177, 11652.242604230698, 11692.707682307926, 11358.31850088989, 11459.942700286487, 11535.59625413115, 11539.826902596467, 11541.249818761753, 11238.775224495464, 11288.661340159808, 11362.71593210168, 11403.030742386907, 11460.54157833694, 40322.59677403247, 40702.592974070474, 40760.18479630391, 40775.0, 40832.387514187314, 3211.903642890717, 3363.697267245935, 3376.1559610097474, 3423.0757695422344, 3533.957482542656, 21449.785502144936, 23885.402864928343, 27285.317867053283, 28274.717252827413, 28451.0, 3089.3029648146103, 3221.532877732739, 3254.1864533866533, 3284.786488878215, 3302.3890580242733, 440750.0, 443868.0, 444030.0, 444477.0, 444983.0, 54548.45451545513, 54946.90106197853, 54956.62608434741, 55011.44988550143, 55076.0, 46852.7657361711, 56515.0, 56615.150772738445, 56685.71657141688, 56714.0, 15259.313330900137, 15431.768523472158, 15464.14947177916, 15465.381384744484, 15499.302531386114, 10414.323069000491, 11534.19260651763, 11564.595239166589, 12095.758084838253, 12170.878291216974, 15072.171030593203, 16576.503356784433, 20705.27531536389, 20909.581808363746, 21335.78664213369, 7388.371988381048, 7503.5873026982945, 8101.339225458767, 8115.6753729851325, 8129.674813007532, 888.5201990924958, 924.7872989212519, 1050.9264351495474, 1069.5080263078914, 1104.4588151805558, 30702.53946190809, 30830.60719699994, 31157.68842311593, 31255.0, 31281.374372512877, 976.8632391465201, 1037.2842738510403, 1049.317943336837, 1059.5338051257422, 1071.6195750508614, 15685.0, 15779.526614201592, 15814.288357023961, 15827.0, 16176.191190440431, 644540.0, 647859.0, 647872.0, 647937.0, 651832.0, 60405.39594603998, 61031.0, 61227.0, 61309.0, 61322.69338653278, 1033.3180101133366, 1238.8637249902504, 1355.5120156743565, 1386.4038463460809, 1389.6595334143199, 29936.85031574828, 30966.0710178686, 31021.534676980315, 31647.52528712117, 31998.68001319957, 51298.97402051863, 52990.0, 54445.18332225099, 54656.45343546513, 54693.453065468835, 520372.0, 526339.0, 526719.0, 527399.0, 527405.0, 25418.364540886625, 25596.104136355138, 26203.082892098686, 26739.598906016814, 38084.80957595194, 43331.0, 43352.0, 43537.56462435335, 43638.47265345698, 43893.78053109714, 35784.642153578134, 36034.27931441304, 36058.27883442264, 36517.81741091277, 36878.0, 35814.820925895205, 35833.32091535371, 36060.45909311415, 36653.900382988555, 36946.8152659235, 28229.576556352084, 35020.64979350174, 35463.468047978786, 35972.28055438929, 36137.277254455286, 31198.844005779825, 31855.36289274248, 31953.881614143393, 32021.67978320187, 32036.67963320337, 23285.88357058204, 23542.88114069742, 24122.517549648557, 24180.758192417852, 24290.271291861274], "value": 19773.82471256163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8467051144939, 352.508250989869, 357.6441440766436, 369.6839202481877, 401.33378591538036, 11271.887281127196, 14995.675670271112, 15132.546023619281, 15845.92077039616, 20174.798252017474, 20085.0, 20524.794752052476, 20769.792302076974, 21153.04811283492, 21420.0, 5065.696058236499, 6033.366496517846, 6036.577439579231, 6057.54568407369, 6075.33171351151, 5500.81732427528, 5693.174489698991, 5866.6480011199255, 5905.29136503618, 5908.0, 5768.42315768424, 5871.266091738533, 5882.911756323659, 5882.941170588282, 5888.911666325009, 5728.856778580548, 5765.827025189251, 5887.587868849182, 5918.852028699274, 5938.198343223696, 5177.378714554277, 5179.171332586768, 5180.3265575475325, 5182.792688292501, 5185.429602743695, 27010.0, 27720.584191237147, 28205.43589128206, 28938.0, 29267.560986585217, 2265.716785401825, 2462.963055554168, 2621.252942911261, 2679.2096331582034, 3030.727234548879, 13435.529756458476, 14404.847612190999, 16734.74897876533, 16891.91554042222, 17304.012920859735, 1642.523668136251, 1869.345728994841, 1910.923563057476, 1999.240288690303, 2034.532057626754, 92651.53674231586, 122412.04321718971, 123479.0, 130563.0, 137896.0, 18804.81195188058, 18837.81162188388, 19521.707174392395, 20276.0, 20903.58192836165, 34848.30303393918, 34871.51284871493, 34975.65024349724, 34992.125196869776, 35061.649383505835, 10341.534630941625, 10550.314229575053, 10660.987206215397, 10790.946045269724, 10809.459527023775, 8739.257163141077, 8753.0, 8806.77983050416, 8935.687250946186, 8962.0, 9069.86626671666, 9548.37935534202, 9776.608935642636, 9976.80046399068, 10000.849902261187, 3078.8768449262225, 3377.594688637379, 3437.8796742113905, 3803.1633040730994, 3803.695704343646, 761.5240474703311, 832.7709879783108, 882.9955850220837, 892.8660601036647, 912.6942474271061, 16188.0, 17774.46676599704, 20141.597168056556, 20573.588528229353, 21312.04095815692, 867.1978419961637, 915.2037727177399, 917.6008436330218, 931.38993958957, 939.2392162348519, 10699.144068474503, 11047.171462140372, 11304.434778261055, 11417.48621312043, 11470.426478676032, 465400.0, 529988.9007769496, 535172.0, 557505.0, 557681.0, 124147.0, 127285.36357318154, 130362.0, 131118.34440827733, 137657.0, 950.4154944708954, 978.6427953796813, 992.8758905136858, 1000.9449480278655, 1004.4073996342194, 13459.730805384033, 15960.840391596399, 17404.477865664052, 18528.0, 19027.619447611247, 51906.74046629743, 53567.0, 53704.0, 53828.0, 53940.92118157693, 74031.6298418526, 76443.61778191074, 79552.20447795448, 79818.6009069951, 82192.0, 7897.802554936173, 7998.84002319962, 8125.4718443301, 8142.3486121111355, 8233.79415514617, 7653.234676532302, 9971.504274358904, 10462.0, 12616.243025418504, 13474.19154850712, 10083.14293285079, 11145.219834611824, 11554.59558915434, 11655.59205427806, 11930.582429614922, 11132.38771867555, 11162.55349786032, 11514.481848316678, 11530.654080377602, 11680.70798230051, 11227.38249396291, 11497.425128743696, 11766.58816941403, 11829.585964491202, 11891.82162267584, 6999.09011828459, 7322.926770732438, 7345.375643070185, 7534.736284230025, 8344.58277086131, 9788.706338809847, 10868.836967445653, 11577.7105572358, 11618.244814087057, 11766.647000589996], "value": 10361.452204859306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.6633574277917, 1493.9178345191015, 1697.6774412861555, 1859.2934684819766, 1886.6509695706304, 8009.87985180222, 8429.325653947684, 8431.789205269855, 8441.0, 8450.0, 7439.181690014094, 7677.0, 8008.559529225905, 8208.056073551543, 8254.834903301931, 2299.287220961499, 2342.1568235435316, 2344.9648255276184, 2347.812175025994, 2350.177437896731, 2341.8711970841596, 2359.1860808021206, 2371.1226846066893, 2372.2171683344454, 2374.95250094998, 2312.2947501012186, 2320.7447180810095, 2342.4612339162004, 2342.917997870075, 2351.200591798788, 2269.239804665439, 2285.5086156476436, 2290.450291929933, 2321.373229228099, 2327.4181454636428, 2190.671399290103, 2221.1892659179284, 2230.565039817236, 2240.003198576634, 2320.97679023211, 7349.412047036224, 8299.543525106117, 8398.454100483448, 8400.285975692073, 8409.327253819742, 4928.088303663833, 5150.871228219287, 5151.459096794858, 5160.767765450564, 5161.329027226474, 3010.458117538842, 3213.8714451422147, 3370.1911541230174, 3580.158662714286, 3582.910427239314, 1015.137133436573, 1031.8761748590143, 1059.0309866472169, 1069.12331887852, 1075.2580719303655, 10292.0, 10669.253152279343, 10687.946560267148, 10695.304805187638, 10857.3485590864, 4263.637590804754, 4327.156204540084, 4433.46798384196, 4452.106131014802, 4481.215787237221, 8567.27178189861, 8615.827683446421, 8623.870641940375, 8639.870401943976, 8668.219860212612, 4973.477784832613, 5063.924041139386, 5064.417591976896, 5069.087564238473, 5076.923846142311, 3833.597472265372, 4202.831886724558, 4701.858944231679, 4730.2431610942085, 4775.140474714584, 3607.8917632471066, 3630.2920930418845, 3675.61406052366, 3694.2057457646197, 3694.630536946284, 1123.4214379594516, 1129.1757017377197, 1132.7224829916722, 1143.4625725908809, 1147.5983405807901, 865.7749284761991, 871.3943809052647, 880.097899652861, 902.5442151713343, 938.6808485115093, 4810.4467986181335, 5532.150942264737, 5602.179291730204, 5813.157092221604, 6061.866492367019, 875.6803766625136, 884.7088829554049, 915.5330781301584, 916.5188276155072, 932.9440233586007, 3437.845296961643, 3633.6184700606586, 3852.3836186210074, 3907.941380879289, 4027.9798601006805, 9660.71017869465, 9995.20038396941, 10002.549885255035, 10034.147097496649, 10066.748331291776, 9748.26887983404, 9844.310898237054, 9918.305718599773, 9974.152197063331, 10001.899981000097, 7069.505134640526, 7687.884681729778, 7863.488873223222, 7877.487963282254, 7897.644605992744, 5439.292891924025, 5690.0, 5729.369769325454, 5775.942240577709, 5784.768609255582, 9124.863127052966, 9217.078292170729, 9290.16388525036, 9375.765605859908, 9399.906000939904, 7286.635668216462, 9438.95280523593, 9441.669541566012, 9544.809103818023, 9564.856527152237, 6606.6036037837885, 6834.794956151323, 6841.657917104026, 7110.217876033736, 7314.37827784623, 6911.308869113049, 7426.777196684108, 7477.401807855467, 7583.696652133853, 7599.88600171009, 6633.734650614115, 6714.83212919681, 6767.526273160832, 6798.354156355138, 6877.2091209509545, 6665.333466653296, 6679.131712877295, 6698.0, 6735.191776986597, 6747.359000894907, 6319.6208227506495, 6333.36666333363, 6334.619922804646, 6340.778072767431, 6400.967995159995, 4603.884902877455, 4632.745199014086, 4638.744869032235, 4707.81168753246, 4709.175894218567, 4690.296455531561, 4691.812327506861, 4711.764411779329, 4738.881527961691, 4740.288956656529], "value": 4328.9247144931915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.2542508182326, 348.07933017169586, 354.4700672494619, 370.4350864930978, 374.2963229129238, 4302.354646802981, 4941.82703605373, 5203.921941170881, 5219.86950326242, 5220.817271395502, 4412.42638457001, 4565.269556870901, 5098.9745051274695, 5190.342526645955, 5206.401263854658, 3788.4467368379037, 3795.924081518368, 4088.3458646616546, 4108.178364327132, 4115.609017143366, 3820.331441997653, 4118.752874827505, 4142.9378559321485, 4161.066448154044, 4162.313218318974, 3221.4523530999786, 4040.1111755413763, 4044.7370920890194, 4083.2650122977852, 4097.508299004124, 3761.9059523511855, 4045.939310910339, 4072.9635182408647, 4077.2660921034203, 4096.160287141129, 3627.310810945938, 3652.3425783358985, 3653.378925582631, 3663.1940972986167, 3674.1365779041903, 4113.25961326961, 4231.640310573605, 4759.0, 5067.417247016603, 5079.79680812767, 4076.1440097579543, 4185.393117997904, 4507.985703216783, 4666.9766651166865, 4681.32120842476, 4376.431063961696, 5463.945360546423, 5495.0383682855345, 5523.917141242885, 5525.889482210374, 3665.6700896919406, 3681.374166391693, 3750.287445385368, 3862.0, 3959.3862951242604, 5081.644284900059, 5495.697736624484, 5770.336411312669, 5806.65160090396, 5807.622504537234, 4110.630043296118, 4125.463689720377, 4132.752034877917, 4134.545200027995, 4163.084121493267, 3866.903327416781, 4206.642435392964, 4222.071144348239, 4222.915541689149, 4251.59609837065, 4345.0, 4392.1874453226255, 4485.663575231871, 4610.9308360374625, 4700.647451441156, 4690.64820138491, 5520.641158324696, 5522.861928451821, 5582.9572882778175, 5610.326760788732, 1117.0337657925998, 1304.9151805132635, 1313.343328335832, 1333.1534475607864, 1374.6494643865951, 871.5706241763513, 892.9598168082451, 913.899471058183, 962.4177372689422, 979.1970584120952, 4087.4481944937647, 4202.957970420318, 4407.201427093819, 4678.1813182692895, 4890.483949975448, 5027.79888804451, 5281.069006701317, 5413.675179489243, 5427.43011983744, 5465.453454654582, 4777.378940737752, 5161.329027226437, 5219.52072765441, 5253.395859476209, 5284.365876094893, 2424.9209101949814, 2548.6686730724887, 2615.882285297166, 2867.211516832888, 2869.512182928907, 4976.377952755905, 5260.106941182335, 5333.466653334713, 5354.330708661418, 5592.384837667853, 4802.759862006886, 5297.973510132425, 5431.94077154951, 5521.806736764194, 5556.91664625031, 4869.394873742602, 5451.400345961941, 5540.36285827127, 5552.361478430033, 5558.304222452108, 4408.404865343137, 5003.323643507024, 5356.812511562077, 5367.758450869798, 5390.0, 4581.6325001124815, 4699.718016918996, 5341.4925582069645, 5350.919736203882, 5353.705546194841, 4804.051826618588, 4963.454020057863, 5134.922976155435, 5317.361916570037, 5584.274044374205, 3473.3949537846615, 3556.7510274281585, 3784.0350710568628, 3822.503074600284, 3833.5783063862395, 5586.742982828831, 5588.497035266845, 5607.691576963306, 5615.438456154352, 5636.2954630671165, 4733.431988161443, 5233.39815921174, 5485.32697527258, 5512.200730893917, 5526.50784288248, 5230.077441918561, 5279.630425870152, 5425.321834770653, 5441.918371224356, 5473.31583552056, 5134.383873935151, 5233.869153271199, 5274.287971123849, 5276.261323414648, 5338.731039308201, 4640.0, 5505.697186654773, 5515.586331025109, 5527.419620939904, 5544.750486228048, 4250.0, 4816.301636262792, 5144.871378215575, 5286.101362768415, 5380.354357477127], "value": 4007.037403576105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6362855029882, 732.6629750314852, 744.6686224630042, 781.9061712594489, 827.8716798896173, 14720.263986800657, 15202.315895784688, 15608.921955390208, 15713.292901819432, 15846.603834904134, 14022.719545609081, 14296.71406571868, 14426.495072672433, 14585.0, 14611.78082328766, 854.9187827156426, 874.1302404107889, 883.2845395229853, 884.2969838977996, 887.40100432208, 690.4441924251001, 711.2887112887113, 711.4628455516104, 876.6537217798966, 878.9121087891224, 896.8789213456165, 926.3469254175824, 927.3045216087934, 928.4104593583089, 928.6424726480286, 882.161946151159, 905.6332185464897, 908.7500937242245, 932.6409332407038, 934.8270569944582, 533.8345113014939, 695.600029982762, 696.4915611603558, 698.3261152987392, 699.5557820783788, 12246.632601021984, 14399.352029158714, 14977.550673479813, 15013.324400402009, 15016.324265408082, 13503.66240843977, 13582.456701731919, 13618.387172577257, 13954.51159209433, 14008.789868151986, 12951.67620809478, 13014.349282535835, 13060.151090179108, 13116.737665246641, 13134.671633209151, 4422.0, 4423.557644235583, 4474.194644963905, 4560.589546940758, 4677.579017888406, 113163.43418282855, 114066.0, 115550.42224788906, 115968.42015789951, 116819.82261241716, 10808.51361688726, 11149.609763658395, 11192.0, 11201.495932683049, 11243.0, 22940.655890161328, 23812.285631431085, 23812.761872381056, 23824.047038118282, 23876.0, 8061.596920153969, 8062.355011599176, 8101.959490202511, 8128.065272493621, 8254.504729716236, 4208.242516347026, 4236.131593023423, 4332.4801023877335, 4427.22523558376, 4436.933445998313, 3596.82015899204, 3647.4893514907935, 3713.294474049922, 3719.1817800083936, 3720.8511659533315, 656.1921905151278, 662.2814246542459, 669.1668872253978, 683.8256244657581, 691.629977961788, 527.8020742221667, 592.5881512348963, 645.6513482719279, 662.3442791636342, 673.3300366135726, 9000.36997410175, 9002.50486223264, 9084.364094513321, 9408.482533460725, 9551.665691700757, 605.9163617251265, 626.4737620398887, 645.7223393940651, 655.4101308822003, 690.7375197425047, 3644.1436262478296, 4195.58044195578, 4411.250087485135, 4472.776361181928, 4516.638668906479, 85884.0, 87194.0, 95657.04342956482, 98555.0, 102683.45974810384, 68830.65584672145, 87474.56262718773, 88431.0, 88853.0, 89290.0, 77779.22220777832, 78619.4276114486, 78687.99999999885, 78859.0, 80064.59967700124, 7810.960945195237, 9783.168430683472, 9796.46119463408, 9887.0, 9957.800843983225, 48507.757461212466, 48714.51285487242, 50381.24428133508, 50399.24401133913, 50976.0, 57832.71083644555, 70647.29352706407, 72460.55078898498, 72561.91157132541, 74474.13814654677, 12991.949241313458, 13103.672408189872, 13109.410076546768, 13370.866291337352, 13559.118657287245, 14412.927935360256, 14675.853241467876, 14708.77936830927, 14895.404183832525, 14934.253287335372, 13686.589402317946, 13722.108062975874, 13889.791653125008, 14401.135931844123, 14483.565493035227, 13382.598522044354, 13631.727365452834, 13776.380062897395, 13937.233452160228, 14237.21695306768, 13378.866211337761, 13670.17978921268, 13811.792823107862, 13852.0, 14169.22069286199, 10185.796284074426, 10261.58953641846, 10461.633842815465, 10502.527386267484, 10742.194335424718, 8288.668453261802, 10398.376097434179, 10725.678229653124, 10769.62306319275, 10778.353298802096], "value": 7512.810290160421, "unit": "score"}], "name": "dromaeo_css", "value": 7296.491581513791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 113.0, 102.0, 162.0, 144.0, 152.0, 114.0, 115.0, 135.0, 115.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 183.0, 184.0, 183.0, 179.0, 183.0, 184.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 87.0, 60.0, 62.0, 59.0, 60.0, 74.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 69.0, 70.0, 68.0, 83.0, 69.0, 69.0, 84.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 106.0, 108.0, 107.0, 108.0, 106.0, 108.0, 105.0, 111.0], "value": 107.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 93.0, 92.0, 94.0, 93.0, 103.0, 149.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 88.0, 102.0, 131.0, 131.0, 85.0, 85.0, 84.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 53.0, 55.0, 56.0, 55.0, 55.0, 57.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 69.0, 82.0, 74.0, 70.0, 71.0, 70.0, 70.0, 73.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 88.0, 88.0, 89.0, 90.0, 88.0, 89.0, 90.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 161.0, 147.0, 148.0, 147.0, 161.0, 148.0, 146.0, 199.0, 162.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 179.0, 179.0, 177.0, 177.0, 176.0, 174.0, 176.0, 176.0, 179.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 83.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1494.0, "alertThreshold": 2.0}]} 08:41:05 INFO - Return code: 0 08:41:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:05 INFO - # TBPL SUCCESS # 08:41:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:05 INFO - 2016-12-13 08:41:05.532 screenresolution[1656:10047] starting screenresolution argv=screenresolution get 08:41:05 INFO - 2016-12-13 08:41:05.535 screenresolution[1656:10047] Display 0: 1600x1200x32@60 08:41:05 INFO - 2016-12-13 08:41:05.541 screenresolution[1657:10050] starting screenresolution argv=screenresolution list 08:41:05 INFO - Available Modes on Display 0 08:41:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:05 INFO - Intel Iris: 08:41:05 INFO - Chipset Model: Intel Iris 08:41:05 INFO - Type: GPU 08:41:05 INFO - Bus: Built-In 08:41:05 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:05 INFO - Vendor: Intel (0x8086) 08:41:05 INFO - Device ID: 0x0a2e 08:41:05 INFO - Revision ID: 0x0009 08:41:05 INFO - Displays: 08:41:05 INFO - Display: 08:41:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:05 INFO - Display Serial Number: 1600x1200 60 08:41:05 INFO - Main Display: Yes 08:41:05 INFO - Mirror: Off 08:41:05 INFO - Online: Yes 08:41:05 INFO - Rotation: Supported 08:41:05 INFO - Return code: 0 08:41:05 INFO - Running post-action listener: _resource_record_post_action 08:41:05 INFO - [mozharness: 2016-12-13 16:41:05.784250Z] Finished run-tests step (success) 08:41:05 INFO - Running post-run listener: _resource_record_post_run 08:41:05 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37487616; Write bytes: 551375872; Read time: 238; Write time: 1631 08:41:05 INFO - TinderboxPrint: CPU usage
53.8% 08:41:05 INFO - TinderboxPrint: I/O read bytes / time
37,487,616 / 238 08:41:05 INFO - TinderboxPrint: I/O write bytes / time
551,375,872 / 1,631 08:41:05 INFO - TinderboxPrint: CPU idle
2,221.0 (46.2%) 08:41:05 INFO - TinderboxPrint: CPU system
961.8 (20.0%) 08:41:05 INFO - TinderboxPrint: CPU user
1,626.9 (33.8%) 08:41:05 INFO - TinderboxPrint: Swap in / out
286,744,576 / 0 08:41:05 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228585984; Write bytes: 222898176; Read time: 16476; Write time: 458 08:41:05 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36566016; Write bytes: 299191296; Read time: 227; Write time: 1105 08:41:06 INFO - Running post-run listener: _upload_blobber_files 08:41:06 INFO - Blob upload gear active. 08:41:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:06 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 08:41:06 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'] 08:41:06 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 08:41:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:07 INFO - (blobuploader) - INFO - Done attempting. 08:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:08 INFO - (blobuploader) - INFO - Done attempting. 08:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:41:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:10 INFO - (blobuploader) - INFO - Done attempting. 08:41:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:10 INFO - Return code: 0 08:41:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c654644bd9052658c2c23c33def86d8f600228f83483972320cf5fd61bd3b37da8c91e95a61dd14e98c36b6ba6306e6027d9b20f1f1db3015f82bae99953c2b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55793278729b25c43471ac64f656db64db76d4dba0b3bc3df6385f510fb8c465faaf8663d1365d4adef850af782d4c219cb66968ddbc8ec518f14037da0cdf20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0eb320e5c5cebfe84a81d45772e0e5e811622921f1615df7d9b9ba028652eed9490f606f6e123b503c367cfc2612e6b399d7c0a7e3946253236b59fbcb0b6aba"} 08:41:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:10 INFO - Contents: 08:41:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c654644bd9052658c2c23c33def86d8f600228f83483972320cf5fd61bd3b37da8c91e95a61dd14e98c36b6ba6306e6027d9b20f1f1db3015f82bae99953c2b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55793278729b25c43471ac64f656db64db76d4dba0b3bc3df6385f510fb8c465faaf8663d1365d4adef850af782d4c219cb66968ddbc8ec518f14037da0cdf20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0eb320e5c5cebfe84a81d45772e0e5e811622921f1615df7d9b9ba028652eed9490f606f6e123b503c367cfc2612e6b399d7c0a7e3946253236b59fbcb0b6aba"} 08:41:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:10 INFO - Copying logs to upload dir... 08:41:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.543075 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-13 08:41:10.956397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:10.960186) ========= 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.Ed5657lxXD/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.w7lwDFbn9N/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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/c654644bd9052658c2c23c33def86d8f600228f83483972320cf5fd61bd3b37da8c91e95a61dd14e98c36b6ba6306e6027d9b20f1f1db3015f82bae99953c2b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55793278729b25c43471ac64f656db64db76d4dba0b3bc3df6385f510fb8c465faaf8663d1365d4adef850af782d4c219cb66968ddbc8ec518f14037da0cdf20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0eb320e5c5cebfe84a81d45772e0e5e811622921f1615df7d9b9ba028652eed9490f606f6e123b503c367cfc2612e6b399d7c0a7e3946253236b59fbcb0b6aba"} build_url:https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c654644bd9052658c2c23c33def86d8f600228f83483972320cf5fd61bd3b37da8c91e95a61dd14e98c36b6ba6306e6027d9b20f1f1db3015f82bae99953c2b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55793278729b25c43471ac64f656db64db76d4dba0b3bc3df6385f510fb8c465faaf8663d1365d4adef850af782d4c219cb66968ddbc8ec518f14037da0cdf20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0eb320e5c5cebfe84a81d45772e0e5e811622921f1615df7d9b9ba028652eed9490f606f6e123b503c367cfc2612e6b399d7c0a7e3946253236b59fbcb0b6aba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:10.996156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:10.996531) ========= 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.Ed5657lxXD/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.w7lwDFbn9N/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.005155 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:11.045440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:41:11.045762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:41:11.046100) ========= ========= Total master_lag: 3.24 =========