builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0111 starttime: 1481654326.35 results: success (0) buildid: 20161213091200 builduid: ace1b13492f34da99303ec294fac7598 revision: 489f981e8c2beb050d7faee956dd940431bdafe6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.349368) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.356067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.356444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.381891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:46.382244) ========= 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.1J2BX6Z76C/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.A5nqghzL8q/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:38:46-- 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% 8.12M=0.001s 2016-12-13 10:38:47 (8.12 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.622526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:47.027830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:47.028128) ========= 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.1J2BX6Z76C/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.A5nqghzL8q/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.019910 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:47.076956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 10:38:47.077290) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 489f981e8c2beb050d7faee956dd940431bdafe6 --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 489f981e8c2beb050d7faee956dd940431bdafe6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1J2BX6Z76C/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.A5nqghzL8q/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:38:47,156 truncating revision to first 12 chars 2016-12-13 10:38:47,156 Setting DEBUG logging. 2016-12-13 10:38:47,156 attempt 1/10 2016-12-13 10:38:47,156 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/489f981e8c2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 10:38:48,734 unpacking tar archive at: mozilla-central-489f981e8c2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.832587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 10:38:48.933049) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.933343) ========= script_repo_revision: 489f981e8c2beb050d7faee956dd940431bdafe6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.933727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.933987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:38:48.953846) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-13 10:38:48.954224) ========= /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.1J2BX6Z76C/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.A5nqghzL8q/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:38:49 INFO - MultiFileLogger online at 20161213 10:38:49 in /builds/slave/test 10:38:49 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 10:38:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:38:49 INFO - {'append_to_log': False, 10:38:49 INFO - 'base_work_dir': '/builds/slave/test', 10:38:49 INFO - 'blob_upload_branch': 'Firefox', 10:38:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:38:49 INFO - 'branch': 'Firefox', 10:38:49 INFO - 'buildbot_json_path': 'buildprops.json', 10:38:49 INFO - 'config_files': ('talos/mac_config.py',), 10:38:49 INFO - 'default_actions': ('clobber', 10:38:49 INFO - 'read-buildbot-config', 10:38:49 INFO - 'download-and-extract', 10:38:49 INFO - 'populate-webroot', 10:38:49 INFO - 'create-virtualenv', 10:38:49 INFO - 'install', 10:38:49 INFO - 'run-tests'), 10:38:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:38:49 INFO - 'download_minidump_stackwalk': True, 10:38:49 INFO - 'download_symbols': 'ondemand', 10:38:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:38:49 INFO - 'tooltool.py': '/tools/tooltool.py', 10:38:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:38:49 INFO - '/tools/misc-python/virtualenv.py')}, 10:38:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:38:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:38:49 INFO - 'installer_path': 'installer.exe', 10:38:49 INFO - 'log_level': 'info', 10:38:49 INFO - 'log_name': 'talos', 10:38:49 INFO - 'log_to_console': True, 10:38:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:38:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:38:49 INFO - 'opt_config_files': (), 10:38:49 INFO - 'pip_index': False, 10:38:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:38:49 INFO - 'cmd': ('bash', 10:38:49 INFO - '-c', 10:38:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:38:49 INFO - 'enabled': True, 10:38:49 INFO - 'halt_on_failure': False, 10:38:49 INFO - 'name': 'check_screen_resolution'},), 10:38:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:38:49 INFO - 'cmd': ('bash', 10:38:49 INFO - '-c', 10:38:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:38:49 INFO - 'enabled': True, 10:38:49 INFO - 'halt_on_failure': False, 10:38:49 INFO - 'name': 'check_screen_resolution'},), 10:38:49 INFO - 'run_cmd_checks_enabled': True, 10:38:49 INFO - 'sps_profile': False, 10:38:49 INFO - 'sps_profile_interval': 0, 10:38:49 INFO - 'suite': 'dromaeojs', 10:38:49 INFO - 'system_bits': '32', 10:38:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:38:49 INFO - 'title': 't-yosemite-r7-0111', 10:38:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:38:49 INFO - 'use_talos_json': True, 10:38:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:38:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:38:49 INFO - 'work_dir': 'build'} 10:38:49 INFO - [mozharness: 2016-12-13 18:38:49.159403Z] Running clobber step. 10:38:49 INFO - Running pre-action listener: _resource_record_pre_action 10:38:49 INFO - Running main action method: clobber 10:38:49 INFO - rmtree: /builds/slave/test/build 10:38:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:38:50 INFO - Running post-action listener: _resource_record_post_action 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.724151Z] Finished clobber step (success) 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.724282Z] Running read-buildbot-config step. 10:38:50 INFO - Running pre-action listener: _resource_record_pre_action 10:38:50 INFO - Running main action method: read_buildbot_config 10:38:50 INFO - Using buildbot properties: 10:38:50 INFO - { 10:38:50 INFO - "project": "", 10:38:50 INFO - "product": "firefox", 10:38:50 INFO - "script_repo_revision": "production", 10:38:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:38:50 INFO - "repository": "", 10:38:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:38:50 INFO - "buildid": "20161213091200", 10:38:50 INFO - "pgo_build": "False", 10:38:50 INFO - "basedir": "/builds/slave/test", 10:38:50 INFO - "buildnumber": 45, 10:38:50 INFO - "slavename": "t-yosemite-r7-0111", 10:38:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:38:50 INFO - "platform": "yosemite_r7", 10:38:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:38:50 INFO - "branch": "mozilla-central", 10:38:50 INFO - "repo_path": "mozilla-central", 10:38:50 INFO - "revision": "489f981e8c2beb050d7faee956dd940431bdafe6", 10:38:50 INFO - "stage_platform": "macosx64", 10:38:50 INFO - "builduid": "ace1b13492f34da99303ec294fac7598", 10:38:50 INFO - "slavebuilddir": "test" 10:38:50 INFO - } 10:38:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 10:38:50 INFO - Running post-action listener: _resource_record_post_action 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.727764Z] Finished read-buildbot-config step (success) 10:38:50 INFO - [mozharness: 2016-12-13 18:38:50.727901Z] Running download-and-extract step. 10:38:50 INFO - Running pre-action listener: _resource_record_pre_action 10:38:50 INFO - Running main action method: download_and_extract 10:38:50 INFO - mkdir: /builds/slave/test/build/tests 10:38:50 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')]} 10:38:50 INFO - trying https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 10:38:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/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 10:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/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 10:38:51 INFO - Downloaded 1235 bytes. 10:38:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 10:38:51 INFO - Using the following test package requirements: 10:38:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 10:38:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 10:38:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 10:38:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'jsshell-mac64.zip'], 10:38:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 10:38:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 10:38:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 10:38:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 10:38:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 10:38:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 10:38:51 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 10:38:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 10:38:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 10:38:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 10:38:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 10:38:52 INFO - Expected file size: 16276433 10:38:52 INFO - Obtained file size: 16276433 10:38:59 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 10:38:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 10:38:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 10:38:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 10:39:00 INFO - Expected file size: 16276433 10:39:00 INFO - Obtained file size: 16276433 10:39:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 10:39:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 10:39:07 INFO - Fetch https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 10:39:07 INFO - Expected file size: 14409734 10:39:07 INFO - Obtained file size: 14409734 10:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:08 INFO - trying https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 10:39:08 INFO - Downloading https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 10:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/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 10:39:11 INFO - Downloaded 69716041 bytes. 10:39:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 10:39:11 INFO - mkdir: /builds/slave/test/properties 10:39:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:39:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:39:11 INFO - Contents: 10:39:11 INFO - build_url:https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 10:39:11 INFO - Running post-action listener: _resource_record_post_action 10:39:11 INFO - Running post-action listener: set_extra_try_arguments 10:39:11 INFO - [mozharness: 2016-12-13 18:39:11.986911Z] Finished download-and-extract step (success) 10:39:11 INFO - [mozharness: 2016-12-13 18:39:11.987066Z] Running populate-webroot step. 10:39:11 INFO - Running pre-action listener: _resource_record_pre_action 10:39:11 INFO - Running main action method: populate_webroot 10:39:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:39:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:39:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:39:11 INFO - '--tppagecycles', 10:39:11 INFO - '7'], 10:39:11 INFO - 'tests': ['tsvgm']}}, 10:39:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:39:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:39:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:39:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:39:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['damp', 'tps']}, 10:39:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:39:11 INFO - 'tests': ['damp', 'tps']}, 10:39:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['dromaeo_dom']}, 10:39:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:39:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['basic_compositor_video']}, 10:39:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:39:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:39:11 INFO - 'tests': ['a11yr', 10:39:11 INFO - 'ts_paint', 10:39:11 INFO - 'tpaint', 10:39:11 INFO - 'sessionrestore', 10:39:11 INFO - 'sessionrestore_no_auto_restore', 10:39:11 INFO - 'tabpaint']}, 10:39:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:39:11 INFO - 'ts_paint', 10:39:11 INFO - 'tpaint', 10:39:11 INFO - 'sessionrestore', 10:39:11 INFO - 'sessionrestore_no_auto_restore', 10:39:11 INFO - 'tabpaint']}, 10:39:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['a11yr', 10:39:12 INFO - 'ts_paint', 10:39:12 INFO - 'tpaint', 10:39:12 INFO - 'sessionrestore', 10:39:12 INFO - 'sessionrestore_no_auto_restore', 10:39:12 INFO - 'tabpaint']}, 10:39:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['tsvgx', 10:39:12 INFO - 'tsvgr_opacity', 10:39:12 INFO - 'tart', 10:39:12 INFO - 'tscrollx', 10:39:12 INFO - 'cart', 10:39:12 INFO - 'tsvg_static']}, 10:39:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:39:12 INFO - 'tsvgr_opacity', 10:39:12 INFO - 'tart', 10:39:12 INFO - 'tscrollx', 10:39:12 INFO - 'cart', 10:39:12 INFO - 'tsvg_static']}, 10:39:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:39:12 INFO - 'talos_options': ['--disable-e10s'], 10:39:12 INFO - 'tests': ['tp5o']}, 10:39:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:39:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:39:12 INFO - 'talos_options': ['--disable-e10s', 10:39:12 INFO - '--xperf_path', 10:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:12 INFO - 'tests': ['tp5n']}, 10:39:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:39:12 INFO - 'talos_options': ['--xperf_path', 10:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:12 INFO - 'tests': ['tp5n']}}, 10:39:12 INFO - 'talos.zip': {'path': '', 10:39:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:39:12 INFO - Running post-action listener: _resource_record_post_action 10:39:12 INFO - [mozharness: 2016-12-13 18:39:12.005730Z] Finished populate-webroot step (success) 10:39:12 INFO - [mozharness: 2016-12-13 18:39:12.005860Z] Running create-virtualenv step. 10:39:12 INFO - Running pre-action listener: _resource_record_pre_action 10:39:12 INFO - Running main action method: create_virtualenv 10:39:12 INFO - Creating virtualenv /builds/slave/test/build/venv 10:39:12 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 10:39:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:39:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:39:12 INFO - Using real prefix '/tools/python27' 10:39:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:39:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:39:15 INFO - Installing pip.................done. 10:39:15 INFO - Return code: 0 10:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:39:15 INFO - Reading from file tmpfile_stdout 10:39:15 INFO - Output received: 10:39:15 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) 10:39:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:39:16 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')]} 10:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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')]} 10:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:16 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 10:39:16 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 10:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:16 INFO - 'HOME': '/Users/cltbld', 10:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:16 INFO - 'LOGNAME': 'cltbld', 10:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:16 INFO - 'MOZ_NO_REMOTE': '1', 10:39:16 INFO - 'NO_EM_RESTART': '1', 10:39:16 INFO - 'PAGER': '/bin/cat', 10:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:16 INFO - 'PWD': '/builds/slave/test', 10:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:16 INFO - 'SHELL': '/bin/bash', 10:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:16 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:16 INFO - 'USER': 'cltbld', 10:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:16 INFO - 'XPC_FLAGS': '0x0', 10:39:16 INFO - 'XPC_SERVICE_NAME': '0', 10:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:16 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 10:39:16 INFO - Cleaning up... 10:39:16 INFO - Return code: 0 10:39:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:39:16 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')]} 10:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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')]} 10:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:16 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 10:39:16 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 10:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:16 INFO - 'HOME': '/Users/cltbld', 10:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:16 INFO - 'LOGNAME': 'cltbld', 10:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:16 INFO - 'MOZ_NO_REMOTE': '1', 10:39:16 INFO - 'NO_EM_RESTART': '1', 10:39:16 INFO - 'PAGER': '/bin/cat', 10:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:16 INFO - 'PWD': '/builds/slave/test', 10:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:16 INFO - 'SHELL': '/bin/bash', 10:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:16 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:16 INFO - 'USER': 'cltbld', 10:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:16 INFO - 'XPC_FLAGS': '0x0', 10:39:16 INFO - 'XPC_SERVICE_NAME': '0', 10:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:16 INFO - Downloading/unpacking psutil>=3.1.1 10:39:16 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 10:39:16 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 10:39:16 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 10:39:16 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 10:39:16 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 10:39:16 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 10:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:39:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:20 INFO - Installing collected packages: psutil 10:39:20 INFO - Running setup.py install for psutil 10:39:20 INFO - building 'psutil._psutil_osx' extension 10:39:20 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 10:39:20 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 10:39:20 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 10:39:21 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 10:39:21 INFO - building 'psutil._psutil_posix' extension 10:39:21 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 10:39:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:39:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:39:21 INFO - ^ 10:39:21 INFO - 1 warning generated. 10:39:21 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 10:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:21 INFO - Successfully installed psutil 10:39:21 INFO - Cleaning up... 10:39:21 INFO - Return code: 0 10:39:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:39:21 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')]} 10:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:21 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')]} 10:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:21 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:21 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 10:39:21 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 10:39:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:21 INFO - 'HOME': '/Users/cltbld', 10:39:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:21 INFO - 'LOGNAME': 'cltbld', 10:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:21 INFO - 'MOZ_NO_REMOTE': '1', 10:39:21 INFO - 'NO_EM_RESTART': '1', 10:39:21 INFO - 'PAGER': '/bin/cat', 10:39:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:21 INFO - 'PWD': '/builds/slave/test', 10:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:21 INFO - 'SHELL': '/bin/bash', 10:39:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:21 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:21 INFO - 'USER': 'cltbld', 10:39:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:21 INFO - 'XPC_FLAGS': '0x0', 10:39:21 INFO - 'XPC_SERVICE_NAME': '0', 10:39:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:39:21 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 10:39:21 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 10:39:21 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 10:39:21 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 10:39:21 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 10:39:21 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 10:39:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:39:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:39:24 INFO - Installing collected packages: mozsystemmonitor 10:39:24 INFO - Running setup.py install for mozsystemmonitor 10:39:24 INFO - Successfully installed mozsystemmonitor 10:39:24 INFO - Cleaning up... 10:39:24 INFO - Return code: 0 10:39:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:24 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:24 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 10:39:24 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 10:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:24 INFO - 'HOME': '/Users/cltbld', 10:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:24 INFO - 'LOGNAME': 'cltbld', 10:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:24 INFO - 'MOZ_NO_REMOTE': '1', 10:39:24 INFO - 'NO_EM_RESTART': '1', 10:39:24 INFO - 'PAGER': '/bin/cat', 10:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:24 INFO - 'PWD': '/builds/slave/test', 10:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:24 INFO - 'SHELL': '/bin/bash', 10:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:24 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:24 INFO - 'USER': 'cltbld', 10:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:24 INFO - 'XPC_FLAGS': '0x0', 10:39:24 INFO - 'XPC_SERVICE_NAME': '0', 10:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:24 INFO - Downloading/unpacking jsonschema==2.5.1 10:39:24 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 10:39:24 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 10:39:24 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 10:39:24 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 10:39:24 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 10:39:24 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 10:39:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:39:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:39:27 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 10:39:27 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 10:39:27 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 10:39:27 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 10:39:27 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 10:39:27 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 10:39:27 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:27 INFO - warning: no files found matching '*.txt' 10:39:27 INFO - no previously-included directories found matching 'build' 10:39:27 INFO - no previously-included directories found matching 'dist' 10:39:27 INFO - no previously-included directories found matching '.git*' 10:39:27 INFO - Installing collected packages: jsonschema, functools32 10:39:27 INFO - Running setup.py install for functools32 10:39:28 INFO - warning: no files found matching '*.txt' 10:39:28 INFO - no previously-included directories found matching 'build' 10:39:28 INFO - no previously-included directories found matching 'dist' 10:39:28 INFO - no previously-included directories found matching '.git*' 10:39:28 INFO - Successfully installed jsonschema functools32 10:39:28 INFO - Cleaning up... 10:39:28 INFO - Return code: 0 10:39:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:39:28 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')]} 10:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 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')]} 10:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:28 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 10:39:28 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 10:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:28 INFO - 'HOME': '/Users/cltbld', 10:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:28 INFO - 'LOGNAME': 'cltbld', 10:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:28 INFO - 'MOZ_NO_REMOTE': '1', 10:39:28 INFO - 'NO_EM_RESTART': '1', 10:39:28 INFO - 'PAGER': '/bin/cat', 10:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:28 INFO - 'PWD': '/builds/slave/test', 10:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:28 INFO - 'SHELL': '/bin/bash', 10:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:28 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:28 INFO - 'USER': 'cltbld', 10:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:28 INFO - 'XPC_FLAGS': '0x0', 10:39:28 INFO - 'XPC_SERVICE_NAME': '0', 10:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:39:28 INFO - Cleaning up... 10:39:28 INFO - Return code: 0 10:39:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39:28 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')]} 10:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 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')]} 10:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:28 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:28 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 10:39:28 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 10:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:28 INFO - 'HOME': '/Users/cltbld', 10:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:28 INFO - 'LOGNAME': 'cltbld', 10:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:28 INFO - 'MOZ_NO_REMOTE': '1', 10:39:28 INFO - 'NO_EM_RESTART': '1', 10:39:28 INFO - 'PAGER': '/bin/cat', 10:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:28 INFO - 'PWD': '/builds/slave/test', 10:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:28 INFO - 'SHELL': '/bin/bash', 10:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:28 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:28 INFO - 'USER': 'cltbld', 10:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:28 INFO - 'XPC_FLAGS': '0x0', 10:39:28 INFO - 'XPC_SERVICE_NAME': '0', 10:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:28 INFO - Downloading/unpacking blobuploader==1.2.4 10:39:28 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 10:39:28 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 10:39:28 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 10:39:28 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 10:39:28 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 10:39:28 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 10:39:31 INFO - Downloading blobuploader-1.2.4.tar.gz 10:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:39:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:39:31 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 10:39:31 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 10:39:31 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 10:39:31 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 10:39:31 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 10:39:31 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 10:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:39:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:32 INFO - Downloading docopt-0.6.1.tar.gz 10:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:39:32 INFO - Installing collected packages: blobuploader, requests, docopt 10:39:32 INFO - Running setup.py install for blobuploader 10:39:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:39:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:39:32 INFO - Running setup.py install for requests 10:39:33 INFO - Running setup.py install for docopt 10:39:33 INFO - Successfully installed blobuploader requests docopt 10:39:33 INFO - Cleaning up... 10:39:33 INFO - Return code: 0 10:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:33 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')]} 10:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:33 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')]} 10:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:33 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:33 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 10:39:33 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 10:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:33 INFO - 'HOME': '/Users/cltbld', 10:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:33 INFO - 'LOGNAME': 'cltbld', 10:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:33 INFO - 'MOZ_NO_REMOTE': '1', 10:39:33 INFO - 'NO_EM_RESTART': '1', 10:39:33 INFO - 'PAGER': '/bin/cat', 10:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:33 INFO - 'PWD': '/builds/slave/test', 10:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:33 INFO - 'SHELL': '/bin/bash', 10:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:33 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:33 INFO - 'USER': 'cltbld', 10:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:33 INFO - 'XPC_FLAGS': '0x0', 10:39:33 INFO - 'XPC_SERVICE_NAME': '0', 10:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:33 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-w2rAVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:33 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RkF9_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-z724tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kODZ0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nudYbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-AttxEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-iABUFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-5NNxfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0s4O6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-7epD9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-VFAlF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:34 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-YWndHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:35 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Qzr4av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:35 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-unURFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:35 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-4lEmji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:35 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-TCDJRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:35 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-VlHZwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:39:35 INFO - Running setup.py install for manifestparser 10:39:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:39:35 INFO - Running setup.py install for mozcrash 10:39:35 INFO - Running setup.py install for mozdebug 10:39:36 INFO - Running setup.py install for mozdevice 10:39:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Running setup.py install for mozfile 10:39:36 INFO - Running setup.py install for mozhttpd 10:39:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Running setup.py install for mozinfo 10:39:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Running setup.py install for mozInstall 10:39:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:39:36 INFO - Running setup.py install for mozleak 10:39:36 INFO - Running setup.py install for mozlog 10:39:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for moznetwork 10:39:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for mozprocess 10:39:37 INFO - Running setup.py install for mozprofile 10:39:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for mozrunner 10:39:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:39:37 INFO - Running setup.py install for mozscreenshot 10:39:37 INFO - Running setup.py install for moztest 10:39:38 INFO - Running setup.py install for mozversion 10:39:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:39:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:39:38 INFO - Cleaning up... 10:39:38 INFO - Return code: 0 10:39:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:38 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')]} 10:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:38 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')]} 10:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:38 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:38 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 10:39:38 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 10:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:38 INFO - 'HOME': '/Users/cltbld', 10:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:38 INFO - 'LOGNAME': 'cltbld', 10:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:38 INFO - 'MOZ_NO_REMOTE': '1', 10:39:38 INFO - 'NO_EM_RESTART': '1', 10:39:38 INFO - 'PAGER': '/bin/cat', 10:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:38 INFO - 'PWD': '/builds/slave/test', 10:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:38 INFO - 'SHELL': '/bin/bash', 10:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:38 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:38 INFO - 'USER': 'cltbld', 10:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:38 INFO - 'XPC_FLAGS': '0x0', 10:39:38 INFO - 'XPC_SERVICE_NAME': '0', 10:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kStR6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:38 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)) 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-6nTgVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:38 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)) 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Rrnuxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:38 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)) 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rC2E13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:38 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)) 10:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-PTQOoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-oXxYnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HpCXfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-PjZWAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-FyM6F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Umptbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nQiV2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-v9UGxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hiwPa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:39 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)) 10:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Z9HhH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:40 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)) 10:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:40 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-XH2l5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:40 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)) 10:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:40 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-zjRsmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:40 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)) 10:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:40 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-q1Cm7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 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)) 10:39:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:42 INFO - Downloading blessings-1.6.tar.gz 10:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:39:43 INFO - Installing collected packages: blessings 10:39:43 INFO - Running setup.py install for blessings 10:39:43 INFO - Successfully installed blessings 10:39:43 INFO - Cleaning up... 10:39:43 INFO - Return code: 0 10:39:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:39:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:43 INFO - Reading from file tmpfile_stdout 10:39:43 INFO - Current package versions: 10:39:43 INFO - blessings == 1.6 10:39:43 INFO - blobuploader == 1.2.4 10:39:43 INFO - docopt == 0.6.1 10:39:43 INFO - functools32 == 3.2.3-2 10:39:43 INFO - jsonschema == 2.5.1 10:39:43 INFO - manifestparser == 1.1 10:39:43 INFO - mozInstall == 1.12 10:39:43 INFO - mozcrash == 1.0 10:39:43 INFO - mozdebug == 0.1 10:39:43 INFO - mozdevice == 0.49 10:39:43 INFO - mozfile == 1.2 10:39:43 INFO - mozhttpd == 0.7 10:39:43 INFO - mozinfo == 0.9 10:39:43 INFO - mozleak == 0.1 10:39:43 INFO - mozlog == 3.4 10:39:43 INFO - moznetwork == 0.27 10:39:43 INFO - mozprocess == 0.23 10:39:43 INFO - mozprofile == 0.28 10:39:43 INFO - mozrunner == 6.13 10:39:43 INFO - mozscreenshot == 0.1 10:39:43 INFO - mozsystemmonitor == 0.3 10:39:43 INFO - moztest == 0.7 10:39:43 INFO - mozversion == 1.4 10:39:43 INFO - psutil == 3.1.1 10:39:43 INFO - requests == 1.2.3 10:39:43 INFO - wsgiref == 0.1.2 10:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:43 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 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39:43 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 10:39:43 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 10:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:43 INFO - 'HOME': '/Users/cltbld', 10:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:43 INFO - 'LOGNAME': 'cltbld', 10:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:43 INFO - 'MOZ_NO_REMOTE': '1', 10:39:43 INFO - 'NO_EM_RESTART': '1', 10:39:43 INFO - 'PAGER': '/bin/cat', 10:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:43 INFO - 'PWD': '/builds/slave/test', 10:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:43 INFO - 'SHELL': '/bin/bash', 10:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:43 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:43 INFO - 'USER': 'cltbld', 10:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:43 INFO - 'XPC_FLAGS': '0x0', 10:39:43 INFO - 'XPC_SERVICE_NAME': '0', 10:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 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)) 10:39:43 INFO - Cleaning up... 10:39:43 INFO - Return code: 0 10:39:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013ec3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101362570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd698578da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, '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.1J2BX6Z76C/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.A5nqghzL8q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 10:39: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'] in /builds/slave/test/build 10:39: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 10:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:43 INFO - 'HOME': '/Users/cltbld', 10:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:43 INFO - 'LOGNAME': 'cltbld', 10:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:43 INFO - 'MOZ_NO_REMOTE': '1', 10:39:43 INFO - 'NO_EM_RESTART': '1', 10:39:43 INFO - 'PAGER': '/bin/cat', 10:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:43 INFO - 'PWD': '/builds/slave/test', 10:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:43 INFO - 'SHELL': '/bin/bash', 10:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:39:43 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:43 INFO - 'USER': 'cltbld', 10:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:43 INFO - 'XPC_FLAGS': '0x0', 10:39:43 INFO - 'XPC_SERVICE_NAME': '0', 10:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:39:44 INFO - Cleaning up... 10:39:44 INFO - Return code: 0 10:39:44 INFO - Running post-action listener: _resource_record_post_action 10:39:44 INFO - Running post-action listener: _start_resource_monitoring 10:39:44 INFO - Starting resource monitoring. 10:39:44 INFO - [mozharness: 2016-12-13 18:39:44.172350Z] Finished create-virtualenv step (success) 10:39:44 INFO - [mozharness: 2016-12-13 18:39:44.173423Z] Running install step. 10:39:44 INFO - Running pre-action listener: _resource_record_pre_action 10:39:44 INFO - Running main action method: install 10:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:44 INFO - Reading from file tmpfile_stdout 10:39:44 INFO - Detecting whether we're running mozinstall >=1.0... 10:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:39:44 INFO - Reading from file tmpfile_stdout 10:39:44 INFO - Output received: 10:39:44 INFO - Usage: mozinstall [options] installer 10:39:44 INFO - Options: 10:39:44 INFO - -h, --help show this help message and exit 10:39:44 INFO - -d DEST, --destination=DEST 10:39:44 INFO - Directory to install application into. [default: 10:39:44 INFO - "/builds/slave/test"] 10:39:44 INFO - --app=APP Application being installed. [default: firefox] 10:39:44 INFO - mkdir: /builds/slave/test/build/application 10:39:44 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'] 10:39:44 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 10:40:06 INFO - Reading from file tmpfile_stdout 10:40:06 INFO - Output received: 10:40:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:40:06 INFO - Running post-action listener: _resource_record_post_action 10:40:06 INFO - [mozharness: 2016-12-13 18:40:06.303316Z] Finished install step (success) 10:40:06 INFO - [mozharness: 2016-12-13 18:40:06.303567Z] Running run-tests step. 10:40:06 INFO - Running pre-action listener: _resource_record_pre_action 10:40:06 INFO - Running main action method: run_tests 10:40:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:40:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:40:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:40:06 INFO - 2016-12-13 10:40:06.318 screenresolution[2166:28712] starting screenresolution argv=screenresolution get 10:40:06 INFO - 2016-12-13 10:40:06.321 screenresolution[2166:28712] Display 0: 1600x1200x32@60 10:40:06 INFO - 2016-12-13 10:40:06.327 screenresolution[2167:28715] starting screenresolution argv=screenresolution list 10:40:06 INFO - Available Modes on Display 0 10:40:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:40:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:40:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:40:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:40:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:40:06 INFO - Intel Iris: 10:40:06 INFO - Chipset Model: Intel Iris 10:40:06 INFO - Type: GPU 10:40:06 INFO - Bus: Built-In 10:40:06 INFO - VRAM (Dynamic, Max): 1536 MB 10:40:06 INFO - Vendor: Intel (0x8086) 10:40:06 INFO - Device ID: 0x0a2e 10:40:06 INFO - Revision ID: 0x0009 10:40:06 INFO - Displays: 10:40:06 INFO - Display: 10:40:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:40:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:40:06 INFO - Display Serial Number: 1600x1200 60 10:40:06 INFO - Main Display: Yes 10:40:06 INFO - Mirror: Off 10:40:06 INFO - Online: Yes 10:40:06 INFO - Rotation: Supported 10:40:06 INFO - Return code: 0 10:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:40:06 INFO - Python 2.7.3 10:40:06 INFO - Return code: 0 10:40:06 INFO - grabbing minidump binary from tooltool 10:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:06 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 0x101201d30>, '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 0x101068db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011f9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:40:06 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 10:40:06 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 10:40:06 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 10:40:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:40:06 INFO - Return code: 0 10:40:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:40:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:40:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:40:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:40:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:40:06 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/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 10:40:06 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/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 10:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1J2BX6Z76C/Render', 10:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:06 INFO - 'HOME': '/Users/cltbld', 10:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:06 INFO - 'LOGNAME': 'cltbld', 10:40:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:40:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:06 INFO - 'MOZ_NO_REMOTE': '1', 10:40:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:40:06 INFO - 'NO_EM_RESTART': '1', 10:40:06 INFO - 'PAGER': '/bin/cat', 10:40:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:06 INFO - 'PWD': '/builds/slave/test', 10:40:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:06 INFO - 'SHELL': '/bin/bash', 10:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A5nqghzL8q/Listeners', 10:40:06 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 10:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:06 INFO - 'USER': 'cltbld', 10:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:06 INFO - 'XPC_FLAGS': '0x0', 10:40:06 INFO - 'XPC_SERVICE_NAME': '0', 10:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:06 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/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 10:40:07 INFO - mozversion application_buildid: 20161213091200 10:40:07 INFO - mozversion application_changeset: 489f981e8c2beb050d7faee956dd940431bdafe6 10:40:07 INFO - mozversion application_display_name: Nightly 10:40:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:40:07 INFO - mozversion application_name: Firefox 10:40:07 INFO - mozversion application_remotingname: firefox 10:40:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:40:07 INFO - mozversion application_vendor: Mozilla 10:40:07 INFO - mozversion application_version: 53.0a1 10:40:07 INFO - mozversion platform_buildid: 20161213091200 10:40:07 INFO - mozversion platform_changeset: 489f981e8c2beb050d7faee956dd940431bdafe6 10:40:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:40:07 INFO - mozversion platform_version: 53.0a1 10:40:07 INFO - using testdate: 1481654407 10:40:07 INFO - actual date: 1481654407 10:40:07 INFO - starting webserver on 'localhost:57136' 10:40:07 INFO - SUITE-START | Running 2 tests 10:40:07 INFO - TEST-START | dromaeo_css 10:40:07 INFO - operating with platform_type : mac_ 10:40:07 INFO - Initialising browser for dromaeo_css test... 10:40:07 INFO - TEST-INFO | started process 2177 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpN2CSAo/profile http://localhost:57136/getInfo.html) 10:40:09 INFO - PROCESS | 2177 | __metrics Screen width/height:1600/1200 10:40:09 INFO - PROCESS | 2177 | colorDepth:24 10:40:09 INFO - PROCESS | 2177 | Browser inner width/height: 1024/689 10:40:09 INFO - PROCESS | 2177 | __metrics 10:40:09 INFO - PROCESS | 2177 | 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" 10:40:09 INFO - PROCESS | 2177 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:40:10 INFO - TEST-INFO | 2177: exit 0 10:40:10 INFO - Browser initialized. 10:40:10 INFO - Running cycle 1/1 for dromaeo_css test... 10:40:10 INFO - TEST-INFO | started process 2179 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpN2CSAo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:22 INFO - PROCESS | 2179 | RSS: Main: 238075904 10:40:22 INFO - PROCESS | 2179 | 10:41:13 INFO - PROCESS | 2179 | 1481654473762 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] 10:43:26 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:57136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57136/tests/dromaeo/cssquery-ext.html) 10:43:28 INFO - PROCESS | 2179 | RSS: Main: 393863168 10:43:28 INFO - PROCESS | 2179 | 10:46:31 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:57136/tests/dromaeo/cssquery-ext.html (next: http://localhost:57136/tests/dromaeo/cssquery-jquery.html) 10:46:32 INFO - PROCESS | 2179 | RSS: Main: 373329920 10:46:32 INFO - PROCESS | 2179 | 10:49:34 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:57136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57136/tests/dromaeo/cssquery-mootools.html) 10:49:35 INFO - PROCESS | 2179 | RSS: Main: 336818176 10:49:35 INFO - PROCESS | 2179 | 10:52:37 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:57136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57136/tests/dromaeo/cssquery-prototype.html) 10:52:38 INFO - PROCESS | 2179 | RSS: Main: 335179776 10:52:38 INFO - PROCESS | 2179 | 10:55:41 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:57136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57136/tests/dromaeo/cssquery-yui.html) 10:55:42 INFO - PROCESS | 2179 | RSS: Main: 330145792 10:55:42 INFO - PROCESS | 2179 | 10:58:45 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:57136/tests/dromaeo/cssquery-yui.html (next: http://localhost:57136/tests/dromaeo/cssquery-dojo.html) 10:58:46 INFO - PROCESS | 2179 | RSS: Main: 493465600 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | __start_tp_report 10:58:46 INFO - PROCESS | 2179 | _x_x_mozilla_page_load 10:58:46 INFO - PROCESS | 2179 | _x_x_mozilla_page_load_details 10:58:46 INFO - PROCESS | 2179 | |i|pagename|runs| 10:58:46 INFO - PROCESS | 2179 | |0;dojo.html;3271.198556353693;3281.8194999275047;3295.5880514935616;3312.27130031393;3346.1634591352163;5471.206675032118;5539.833804985852;5589.944100558993;5604.355499117602;5631.239782629344;5568.99758043553;5584.21820945068;5592.217089607448;5597.496225339719;5624.746886390112;5048.368953880756;5086.745662716868;5099.209622508517;5129.281900533928;5190.896182076375;5099.388073431193;5120.385553733558;5183.766730497118;5184.092783762845;5189.974050129763;5089.796408143669;5101.107306221415;5111.258867464216;5127.897442051157;5147.459516750743;5188.740562971836;5190.948090519084;5208.166693329049;5212.374515058179;5252.71110088945;5002.24966255061;5008.073506401291;5057.393112826448;5152.433232344477;5155.61332900034;4470.821167153343;5521.199426083235;5562.249096371978;5582.469665381782;5618.01684705179;6124.2957059938235;6131.724072416752;6133.386661333876;6134.8159555213415;6140.723667434976;4940.55535001848;6040.758369665208;6122.969385153046;6228.657423841732;6243.594166379171;5585.553155747531;5592.804251851166;5632.9436705632825;5639.605227634108;5684.289463817023;6296.779612713533;6297.559170857996;6321.431071203522;6327.810165695037;6333.683315834282;5826.82519524415;5939.792107276225;5951.077582974646;5952.642841429528;5956.672383018976;6076.422739839708;6101.481374083164;6103.186149163621;6107.633541987495;6178.752849885954;4953.6037117030555;6069.089636554464;6076.939230607726;6091.756329746849;6129.1419201311855;6094.207752992172;6104.175936248638;6108.114323423168;6116.969415152896;6124.448799608057;4740.3837501124635;4836.637252206028;4840.201366774513;4849.830255941025;4851.708897466164;4343.565643435694;4380.452443444569;4388.385626012361;4393.253146965024;4410.07388448423;5635.915461268084;5678.829635110953;5694.032014557535;5711.371749107595;5730.111832665943;6143.692815359214;6201.255849298113;6202.41077097675;6208.286047104551;6215.65813880241;5538.390777014525;5590.329160500766;5591.524720398812;5680.744366503517;5688.345840228427;5230.137027390514;5295.655782374133;5296.523312901857;5341.4925582069645;5356.91964620531;6275.297604248513;6351.301356850743;6351.364863513704;6358.078078678565;6364.936350636434;6113.14415981754;6152.569320147547;6160.784372546939;6170.444659980623;6181.690915454299;6175.320714721467;6235.625862448268;6245.313015568375;6293.37066293367;6293.905591416041;6049.243844519435;6059.303180134341;6060.030395136757;6077.6961151943115;6081.483073938588;5905.379935106752;5916.26046744157;5967.6419414835245;5968.432998865101;6172.259328880563;5716.171155182558;5802.854928626818;5819.6508209507565;5963.940360596339;5963.970180149072;5810.244668193108;5830.067189249699;5862.970685146547;5906.734196961061;6004.849878753066;5820.359760426434;5824.650520968756;5829.883402332014;5843.094320380348;5848.122781582797;5902.291724993029;5998.7300571473515;6001.189839371804;6016.909746353896;6017.819465416044;5642.210090587239;5675.545956323402;5683.976884160891;5800.6809625471005;5801.3038435388025 10:58:46 INFO - PROCESS | 2179 | |1;ext.html;441.27190136275163;444.35790283041;468.0335108001976;485.3665965914481;504.3267238236954;30220.395592088145;39116.41325380118;40432.19135617286;40512.79743601285;40699.18601627966;41466.58533414665;41569.37645935306;42013.57986420143;42063.57936420635;42101.57898421015;8366.53187309745;9300.209482194005;9497.572609232566;9514.762130946747;9530.523473826315;8478.152184781535;11117.444127793618;11379.772404551904;11505.367204803733;11548.3648399338;11315.773684526304;11358.091352691807;11371.31772093673;11380.71548211293;11435.714107147305;11245.381504017276;11320.377379244139;11337.829932551018;11344.943275283571;11351.716207094847;11176.720581985433;11248.606298779503;11263.66209013731;11265.71835704114;11281.717957051058;38941.22117557633;39272.80363598164;39284.41073383902;39308.213835723414;39335;3273.312604353089;3334.6998770110563;3381.2561236527927;3460.2560449503476;3474.818561689038;27612.585811212848;27755.306117347027;28537.286567835763;28815.85592072047;28870.566941495894;3065.6321241450946;3220.146661134801;3275.395056422336;3281.5241789940565;3293.1602441377536;436415;437555;437609;437659;438848.9999999968;53449;54139.72930135324;54578.72710636421;54579;54597;57296;57488.712556437786;57555;57589.848203035705;57606;14825.70348593022;15072.623184420258;15082.360586897468;15087.622809429851;15091.698166036836;10556.683299501028;10828.566857325777;11600.6519804406;11696.649100526998;11744.412779360997;16566.75749318806;16657.881760835262;20659.4835129123;21117.944102794798;21142.57714845725;7048.259932707095;7671.6164191790185;8169.918300816916;8383.574792285326;8402.537860417735;864.9221570058725;932.9923682422967;987.481572174614;1026.609888242463;1044.5821671331528;26278.868605656848;28670;30394.1369380898;31613;32125.839370802998;1075.8117329467311;1075.9623413180502;1111.1777284809345;1175.7060734816296;1208.2327721896659;11565.363904985306;14034.598769732995;15272.423381701086;15775.605609859846;16061.518154455385;419226;530999;532411;535144;535649;58924.11613825796;59493.373460847935;59540.40459595435;59590;59797;1269.6444995401303;1312.757139929097;1394.8256467941508;1399.2863639543702;1437.6190309567974;24461.755382445946;29226;30396.392072158877;30461.847690761406;31859.20351991126;49913.251301231234;50578.747106264236;50662.2400663983;50736.74631626818;50904.74547627238;552356;557042;557904;557982;558550;36848.44727329039;37925.62074379331;38095;38925.61074389333;39228.607713922494;41430.792846035576;41713.79143104265;42215.366769499095;42238.366424503045;42465.575344246165;30419;33745.66254337425;34859.82570087133;35284.47073293851;36122.277554448236;34321.65678343185;34874;35689.1077723059;35739.82130089333;35866;34288.828555857064;34797.652023480456;35116.29767404689;35333;35706;30543.847280763453;31291.061268161993;31396.686033139376;31520.36959260756;31680.5247921286;23701.762982369957;29837;31381.8430907844;32433.675663243066;32523.674763252064 10:58:46 INFO - PROCESS | 2179 | |2;jquery.html;351.12394575534046;370.69973321609496;371.69520992785925;379.79491074819606;394.94470774091633;11505.4822532986;14904.701905961874;15572.688546229068;20032.899835500837;20425.28511502098;18917.337893173742;19159.425217243504;19761.505962350948;20006.399808005746;20026.09882555285;5745.971270143644;6085.300190478085;6085.5435842312;6085.878282434349;6093.451589356957;4619.2609182530805;6059.757609695607;6082.908756368636;6085.878282434349;6089.604175728564;5597.972010139964;6005.759769609211;6018.759249630009;6021.759129634809;6022.939770602304;5824.388439213864;5841.094630332305;5893.263342082239;5906.084556893688;5913.2608423947;5141.331626888481;5144.794208231666;5160.0969830279555;6918.273581273944;7308.6345682715655;26265.212043638723;26366.73633263662;26564.601530977052;26860.194194174204;27051.729482705316;2109.282843833104;2400.23192578375;2518.3704073981503;2540.7840333571485;2969.9902033308776;14679.853201467955;15764.265930747608;16219.51341459758;16284.26720797567;16947.83052169475;1709.5127888551704;1827.41522712732;2024.2206750401053;2024.979750202494;2027.1485975890162;125149;134283.98574021398;134304;135381;136631;9124.224440922464;9691.51542422876;9695.90304096964;9815.75460613476;9844.280832494835;11826.408679566159;11838;12250.44872980718;12274.509019639294;12385.256884586774;7512.948187253789;7652.273034061755;7818.413618978486;7878.487898286593;7945.920540794518;7086.503944723923;7813.609319534001;8140.982377202849;8253.050899146554;8275.95862020686;3800.410936304877;3802.980985095057;3807.371783655721;3878.864239751595;3897.707671924617;1857.3499275253823;1945.1538580717433;1945.4455480188078;1957.6476234277682;1958.8432925365937;810.5825499867573;895.0735988252128;926.5876684875301;948.8956214816365;952.7808604021114;19271.807281927002;19949.900250498944;20110.095045722977;20330.593388132154;20375.008662422893;840.7813968368268;928.6331898899897;965.8792650918635;975.317277905469;1020.9688214903001;9079.500627465553;9161.49611771359;10820.621278255223;10881.455927203608;10903.400312982862;492016;494484;498647;515374;517110;108020.8395832079;117398.23902641467;119543.2068518973;119654.4017279908;125450;966.9951650241563;972.9659461918799;984;985.8521221816785;1012.3925644613173;14294.571162865132;17453.127343633023;17538.82461175372;17675.64648706993;17764;50368.74815625898;50657.73355666138;50783.74608127084;51713;51869;59842;72224;72695.1826204349;80856;82947.5852620733;6582.703778329891;6590.978398348264;6702.899456508058;7185.425165986604;7331.193568707331;9104.13510716481;12236.755264894475;12587.74824503523;12730.618081457571;12914.771307173207;10845.511951962022;10912.072473839495;10942.288751231144;11130.721731956766;11277.492512836778;10506.474676266309;10647.361158330525;10685.465726713477;10809.135269178603;11192.496337664987;8825.646974120964;11001.064909482784;11520.827187592025;11553.942230288794;11655.650330490098;6576.506761992965;6761.695723692544;7315.341619254293;7459;7538.811529711582;9287.674931377369;10203.132733717717;10742.83885741699;11025.944870275598;11048.392338421463 10:58:46 INFO - PROCESS | 2179 | |3;mootools.html;1356.5998030580977;1481.4740767027704;1507.163524244044;1708.8803783735136;1886.594382207826;6602.570832895864;7461.253874612536;7839.960800195998;8362.540060296682;8383.538905360203;8221.6300266488;8223.054348749896;8248.91751082489;8325.542095184763;8331.958340208306;2060.186226440555;2275.5790178816887;2316.085146367184;2317.640765681322;2322.001539338084;2138.2088627207954;2266.9659955100688;2336.544373847092;2339.982107783111;2357.422431504275;1922.7598199161532;2315.710536182977;2316.6872472216205;2321.3964369263945;2324.465372964219;2273.1930164791424;2295.850769699964;2299.172158134287;2305.0664480885184;2306.2504685976955;2281.4296425893526;2313.306008197534;2316.1893337331967;2320.7795259450327;2328.080408238753;8227.83544329116;8237.50574965504;8299.128591497927;8349.332053435772;8366.037905640807;5016.598672106223;5191.974040129813;5195.766190521435;5201.765920533585;5207.661502002357;3310.7185889199445;3465.3935561276676;3522.788632682047;3544.220271540257;3560.305740380627;998.4209158687944;1032.6695457453618;1076.2896488317751;1082.837574363844;1085.0776839686282;10418.27072104953;10671.092957098655;10763.515641796137;10763.838542421792;10815.567377304898;4314.676399270067;4393.7363758174615;4439.578240067189;4442.244818380883;4450.087732014929;8638;8639.568021599021;8647.135286471303;8660.566971651393;8680.913190868137;5049.596032317406;5065.11360511909;5073.670211436245;5081.822136225214;5085;4241.660667146621;4405.449318835145;4683.461401938753;4685.461171965268;4713.010267843722;3382.6279109297957;3533.3993221152464;3643.2349206666368;3646.9759283597327;3649.635036496329;969.4280374579032;997.5610731278215;998.8052329795765;1003.9609004680121;1007.2797949466167;789.8341348316803;844.5819319436795;850.8681154421074;881.8809460722848;937.329809186435;5355.598330125178;5420.105682562333;5527.474889885454;5570.610057296031;5682.602217844711;812.7764864662147;898.3217670658611;904.6019751309403;907.7095329494631;933.8459154239611;3772.3398405278967;3833.4441505982036;3834.386498160281;3857.9614203858164;3861.575226725058;9466.90533094674;9997.600095996224;10126.189904807597;10148.441835698959;10158.13655839262;10068.949655251678;10082.193424526167;10090;10091.142252908438;10113.747156321004;7326.157491888501;7641;7802.453828231969;7848.960755196187;7920.5247685139075;5707.229524014205;5807.535397168132;5842.357340692605;5945.197398351167;5976.850578735566;8907;9197.172254497127;9205.723828285161;9301.860572068597;9331.486768227813;9279.211267042378;9280.164785169367;9355.158035776813;9392.154706076486;9510;7090.326418990187;7108.147022357351;7172.713091476491;7272.272772722686;7280.563166210044;7162.140543134648;7442.776716698508;7464.925350746423;7640.80897977555;8002.079760827346;7228.241034691492;7373.18894921569;7401.59291238987;7447;7512;7251.311125443074;7270.527415717961;7281.490295679251;7282.6722797473185;7358.190599033995;6437.903431448438;6521.380468855451;6561.311062338385;6657.3342665733035;6667.933320666732;5029.220470827027;5034.899302014012;5082.263071854486;5121;5166.560842328444;4985;5034.018366418513;5141.511556402136;5184.870378240575;5244.921326180034 10:58:46 INFO - PROCESS | 2179 | |4;prototype.html;345.6422602606303;346.93234819210255;359.92081742016757;365.5978423733893;367.7480925565989;4932.161532539468;5123.231515272711;5129.794808207676;5139;5168.405633352161;4891.657583969123;4970.577500912426;5030.132824290156;5041.873953151164;5064.84805455836;3454.616314742832;3867.458555802176;4074.5110586729484;4087.1417002429525;4111.691623128278;3177.8093314401094;4039.7172197946156;4080.1839632073556;4085.9785053736564;4096.443351526415;3771.4531392948006;3846.499955005845;3946.565877753445;4055.3981177434894;4091.5703851095654;3368.865245390169;3546.822658867059;3572.964270357289;4087.4073259377224;4088.632023117934;3436.536067630888;3582.695470884978;3604.6395360464007;3610.205754733954;3613.6205698401554;4405.801738921724;4874.3929492175885;5033.375969302097;5043.495650434964;5117.5650069744115;4064.9593504065174;4342.956570434287;4587.7017993830295;4616.75347656131;4619.145458090264;4492.573205545468;5372.973135134299;5392.622516423852;5451.863703407407;5454.836354909319;3807.7905715185652;3957.3668213086057;3974.8012599369918;3975.15155452713;3981.601839816024;4961.668016032459;5085.898282034339;5267.367915850046;5595.944040559583;5671.574631902624;3482.0946553895665;3850.8844734658005;4049.3521036633997;4061.8578349757618;4095.1809638072505;3490.7730997485082;3663.4504824276573;4137.565555616678;4150.3566947123245;4155.340582027505;4355.564443555619;4584.564466375689;4677.4854765975715;4685.226937555333;4686.953130468652;4432.468103827497;5174.593813876565;5416.350037995387;5461.5357694596405;5471.823557935063;1110.0342701849281;1156.8611766588062;1179.280638810325;1192.8866757658009;1338.8084604701824;828.3662997806682;844.1727107434625;899.1862364560084;900.2617853360182;907.6340108137343;3726.466003117906;4844.224924012141;4901.950980490221;4952.77482256216;4972.154733695281;5280.940433231043;5362.410134885159;5382.973085134549;5401.4102794590535;5411.242426060355;4519.966015293131;4762.880927976828;5096.898062038738;5192.714400707997;5218.243354713545;2526.7473252674586;2756.3798145417522;2791.4269734739564;2806.7052959439375;2820.943581128407;4941.160002799533;5334.973325133349;5481.643693159932;5504.422035686275;5601.8599535011135;4571.702839315434;4574.428196475441;4712.88217794551;5531.280933478622;5556.527170518426;4647;4848.733319667452;5027.497250274943;5169.431362550116;5576.86057848557;4796.9280460792415;4817.78319975595;5325.245701780158;5349.411564727799;5367.3827509836865;4374.628156606596;4420.347791325179;4627.352170696038;5291.814786482609;5316.6012549058205;5489.615726899079;5534.667919924817;5592.888142237214;5594.86012849682;5607.299087614048;2953.1344028415947;3308.71875890552;3565.982170089133;3570.3216388887067;3589.3000864831106;4448.7108337957925;4577.679562430598;4855.75721213945;4919.409670839379;5194.013137503862;4302.440682711227;4578.939477235191;4848.5636292732415;5007.712236249014;5139.743012849417;4312.331588603772;4423.469183697976;5086.796528138833;5115.641905066758;5124.154514505065;4529.592336689714;5042.9409823937385;5345.839624811262;5373.5432488237375;5398.299535646259;5355.946440535545;5472.34331880161;5480.26016487785;5480.314960629921;5491.148871924858;4715.740634265148;5363.490468405495;5368.215408137332;5397.298351214317;5415.106507426388 10:58:46 INFO - PROCESS | 2179 | |5;yui.html;697.3653974882856;703.4653663215954;735.3896266099139;761.3300295739748;788.964496597653;14127;15112.395504179847;15408.768868466968;15427.382904683813;15511.457099001536;13715.862841371583;13902.513412030581;13922.791158132612;13934;13936.79094813576;677.3903486861815;701.1340993872564;704.031956060417;851.9914800852005;855.1320409784074;871.3813192633238;875.5140896802272;881.3786280672143;884.8584226523758;889.9110088991082;936.2135805923024;938.5494962418044;939.7791518993031;939.8026414452974;941.1153515695258;932.883389576303;933.2347475070445;934.042606328512;934.4066517761203;935.4480856294819;526.5419085395692;546.9917951230734;666.4102269491535;685.4550632247325;695.3741632530712;14588.635284117876;14640.267986600735;14642.048266862726;14647.487337943227;14663.193524356157;12104.455299511543;12350.81473777885;12428.192167509083;12472.126951113425;12582.496700131984;12142.939285303517;12177.26936383811;12189.695257618541;12226.205296655779;12540.623781286486;4275.358696195564;4280.850170244026;4387.232234358974;4458.420405347284;4479.552044795527;85707.14292857054;101288.454904078;103987.96012039934;104627;107703;9288.90711092894;10033.749156271151;10351.275410721328;10486.737831554272;10811.35131892089;20431;20570.485737856376;20594.38216853497;20680.896595517228;20997.475063123544;7464.925350746532;7486.663100160397;7509.09890813095;7696.037995250594;7735.574543400055;4183.412857114603;4269.103488267437;4282.721623094551;4296.849610263625;4305;2896.6241035507965;3358.815265160391;3409.5908490980746;3424.503447000171;3455.4989526518516;631.608402790273;639.9072134540465;641.2049059166693;642.4025656139835;646.5797231799368;579.5334755521761;614.5312702640692;616.6269407008784;619.1393962392189;629.9149614802035;8549;8632.35257355701;8658.956705216433;8790.011396125348;8813.667731022768;542.9918551221734;590.7755053079889;610.4475449718012;610.9419605137505;621.564904566805;4265.3815196796295;4391.956080439219;4396.340548917688;4528.162289976365;4604.286335617984;104792;104874.42688359528;105520;106188.46905765422;108144;66606.00090998542;76874.92500300037;77107;77969;80497;76191.85712214433;77770;78265;78768.18477228346;78776;9691;9820.11618954269;9820.852687209555;9863.753406164617;9868.309218354647;32725.50911736278;47077;50651.746741266055;50954.74522627363;51451.71370715612;66612.666936665;67347.66326168338;68103;70232.94650580143;70233;13068;13128.934355328161;13167.67080822987;13207.735845283232;13432.261225632685;14560.635984100481;14685.779713304522;14920.889944465911;14981.250937453302;15270;13483.932580337036;13626.1143025703;13708.17750934947;13778.65553361174;14298.642533936734;11206.83189752138;13502.25737584403;13687.726245475234;13742.725145496834;14017.439302427789;13145;13765.311734413439;13803.654908627364;13824.170549767046;13888.097273677582;10805.405702686428;11064.778704426028;11110;11133.053690436403;11160.441977901235;9534;11149.83275250888;11291.548338066385;11436.82844757346;11489.368084755419 10:58:46 INFO - PROCESS | 2179 | __end_tp_report 10:58:46 INFO - PROCESS | 2179 | __start_cc_report 10:58:46 INFO - PROCESS | 2179 | _x_x_mozilla_cycle_collect,1785 10:58:46 INFO - PROCESS | 2179 | __end_cc_report 10:58:46 INFO - PROCESS | 2179 | __startTimestamp1481655526207__endTimestamp 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | ------- Summary: start ------- 10:58:46 INFO - PROCESS | 2179 | Number of tests: 6 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | [#0] dojo.html Cycles:165 Average:5623.37 Median:5801.30 stddev:636.02 (11.0%) stddev-sans-first:610.61 10:58:46 INFO - PROCESS | 2179 | Values: 3271.2 3281.8 3295.6 3312.3 3346.2 5471.2 5539.8 5589.9 5604.4 5631.2 5569.0 5584.2 5592.2 5597.5 5624.7 5048.4 5086.7 5099.2 5129.3 5190.9 5099.4 5120.4 5183.8 5184.1 5190.0 5089.8 5101.1 5111.3 5127.9 5147.5 5188.7 5190.9 5208.2 5212.4 5252.7 5002.2 5008.1 5057.4 5152.4 5155.6 4470.8 5521.2 5562.2 5582.5 5618.0 6124.3 6131.7 6133.4 6134.8 6140.7 4940.6 6040.8 6123.0 6228.7 6243.6 5585.6 5592.8 5632.9 5639.6 5684.3 6296.8 6297.6 6321.4 6327.8 6333.7 5826.8 5939.8 5951.1 5952.6 5956.7 6076.4 6101.5 6103.2 6107.6 6178.8 4953.6 6069.1 6076.9 6091.8 6129.1 6094.2 6104.2 6108.1 6117.0 6124.4 4740.4 4836.6 4840.2 4849.8 4851.7 4343.6 4380.5 4388.4 4393.3 4410.1 5635.9 5678.8 5694.0 5711.4 5730.1 6143.7 6201.3 6202.4 6208.3 6215.7 5538.4 5590.3 5591.5 5680.7 5688.3 5230.1 5295.7 5296.5 5341.5 5356.9 6275.3 6351.3 6351.4 6358.1 6364.9 6113.1 6152.6 6160.8 6170.4 6181.7 6175.3 6235.6 6245.3 6293.4 6293.9 6049.2 6059.3 6060.0 6077.7 6081.5 5905.4 5916.3 5967.6 5968.4 6172.3 5716.2 5802.9 5819.7 5963.9 5964.0 5810.2 5830.1 5863.0 5906.7 6004.8 5820.4 5824.7 5829.9 5843.1 5848.1 5902.3 5998.7 6001.2 6016.9 6017.8 5642.2 5675.5 5684.0 5800.7 5801.3 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | [#1] ext.html Cycles:180 Average:64222.90 Median:19136.24 stddev:134326.06 (701.9%) stddev-sans-first:134617.52 10:58:46 INFO - PROCESS | 2179 | Values: 441.3 444.4 468.0 485.4 504.3 30220.4 39116.4 40432.2 40512.8 40699.2 41466.6 41569.4 42013.6 42063.6 42101.6 8366.5 9300.2 9497.6 9514.8 9530.5 8478.2 11117.4 11379.8 11505.4 11548.4 11315.8 11358.1 11371.3 11380.7 11435.7 11245.4 11320.4 11337.8 11344.9 11351.7 11176.7 11248.6 11263.7 11265.7 11281.7 38941.2 39272.8 39284.4 39308.2 39335.0 3273.3 3334.7 3381.3 3460.3 3474.8 27612.6 27755.3 28537.3 28815.9 28870.6 3065.6 3220.1 3275.4 3281.5 3293.2 436415.0 437555.0 437609.0 437659.0 438849.0 53449.0 54139.7 54578.7 54579.0 54597.0 57296.0 57488.7 57555.0 57589.8 57606.0 14825.7 15072.6 15082.4 15087.6 15091.7 10556.7 10828.6 11600.7 11696.6 11744.4 16566.8 16657.9 20659.5 21117.9 21142.6 7048.3 7671.6 8169.9 8383.6 8402.5 864.9 933.0 987.5 1026.6 1044.6 26278.9 28670.0 30394.1 31613.0 32125.8 1075.8 1076.0 1111.2 1175.7 1208.2 11565.4 14034.6 15272.4 15775.6 16061.5 419226.0 530999.0 532411.0 535144.0 535649.0 58924.1 59493.4 59540.4 59590.0 59797.0 1269.6 1312.8 1394.8 1399.3 1437.6 24461.8 29226.0 30396.4 30461.8 31859.2 49913.3 50578.7 50662.2 50736.7 50904.7 552356.0 557042.0 557904.0 557982.0 558550.0 36848.4 37925.6 38095.0 38925.6 39228.6 41430.8 41713.8 42215.4 42238.4 42465.6 30419.0 33745.7 34859.8 35284.5 36122.3 34321.7 34874.0 35689.1 35739.8 35866.0 34288.8 34797.7 35116.3 35333.0 35706.0 30543.8 31291.1 31396.7 31520.4 31680.5 23701.8 29837.0 31381.8 32433.7 32523.7 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | [#2] jquery.html Cycles:180 Average:32076.10 Median:2090.10 stddev:85242.14 (4078.4%) stddev-sans-first:85447.98 10:58:46 INFO - PROCESS | 2179 | Values: 351.1 370.7 371.7 379.8 394.9 11505.5 14904.7 15572.7 20032.9 20425.3 18917.3 19159.4 19761.5 20006.4 20026.1 5746.0 6085.3 6085.5 6085.9 6093.5 4619.3 6059.8 6082.9 6085.9 6089.6 5598.0 6005.8 6018.8 6021.8 6022.9 5824.4 5841.1 5893.3 5906.1 5913.3 5141.3 5144.8 5160.1 6918.3 7308.6 26265.2 26366.7 26564.6 26860.2 27051.7 2109.3 2400.2 2518.4 2540.8 2970.0 14679.9 15764.3 16219.5 16284.3 16947.8 1709.5 1827.4 2024.2 2025.0 2027.1 125149.0 134284.0 134304.0 135381.0 136631.0 9124.2 9691.5 9695.9 9815.8 9844.3 11826.4 11838.0 12250.4 12274.5 12385.3 7512.9 7652.3 7818.4 7878.5 7945.9 7086.5 7813.6 8141.0 8253.1 8276.0 3800.4 3803.0 3807.4 3878.9 3897.7 1857.3 1945.2 1945.4 1957.6 1958.8 810.6 895.1 926.6 948.9 952.8 19271.8 19949.9 20110.1 20330.6 20375.0 840.8 928.6 965.9 975.3 1021.0 9079.5 9161.5 10820.6 10881.5 10903.4 492016.0 494484.0 498647.0 515374.0 517110.0 108020.8 117398.2 119543.2 119654.4 125450.0 967.0 973.0 984.0 985.9 1012.4 14294.6 17453.1 17538.8 17675.6 17764.0 50368.7 50657.7 50783.7 51713.0 51869.0 59842.0 72224.0 72695.2 80856.0 82947.6 6582.7 6591.0 6702.9 7185.4 7331.2 9104.1 12236.8 12587.7 12730.6 12914.8 10845.5 10912.1 10942.3 11130.7 11277.5 10506.5 10647.4 10685.5 10809.1 11192.5 8825.6 11001.1 11520.8 11553.9 11655.7 6576.5 6761.7 7315.3 7459.0 7538.8 9287.7 10203.1 10742.8 11025.9 11048.4 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | [#3] mootools.html Cycles:180 Average:5399.19 Median:5198.77 stddev:2946.04 (56.7%) stddev-sans-first:2938.64 10:58:46 INFO - PROCESS | 2179 | Values: 1356.6 1481.5 1507.2 1708.9 1886.6 6602.6 7461.3 7840.0 8362.5 8383.5 8221.6 8223.1 8248.9 8325.5 8332.0 2060.2 2275.6 2316.1 2317.6 2322.0 2138.2 2267.0 2336.5 2340.0 2357.4 1922.8 2315.7 2316.7 2321.4 2324.5 2273.2 2295.9 2299.2 2305.1 2306.3 2281.4 2313.3 2316.2 2320.8 2328.1 8227.8 8237.5 8299.1 8349.3 8366.0 5016.6 5192.0 5195.8 5201.8 5207.7 3310.7 3465.4 3522.8 3544.2 3560.3 998.4 1032.7 1076.3 1082.8 1085.1 10418.3 10671.1 10763.5 10763.8 10815.6 4314.7 4393.7 4439.6 4442.2 4450.1 8638.0 8639.6 8647.1 8660.6 8680.9 5049.6 5065.1 5073.7 5081.8 5085.0 4241.7 4405.4 4683.5 4685.5 4713.0 3382.6 3533.4 3643.2 3647.0 3649.6 969.4 997.6 998.8 1004.0 1007.3 789.8 844.6 850.9 881.9 937.3 5355.6 5420.1 5527.5 5570.6 5682.6 812.8 898.3 904.6 907.7 933.8 3772.3 3833.4 3834.4 3858.0 3861.6 9466.9 9997.6 10126.2 10148.4 10158.1 10068.9 10082.2 10090.0 10091.1 10113.7 7326.2 7641.0 7802.5 7849.0 7920.5 5707.2 5807.5 5842.4 5945.2 5976.9 8907.0 9197.2 9205.7 9301.9 9331.5 9279.2 9280.2 9355.2 9392.2 9510.0 7090.3 7108.1 7172.7 7272.3 7280.6 7162.1 7442.8 7464.9 7640.8 8002.1 7228.2 7373.2 7401.6 7447.0 7512.0 7251.3 7270.5 7281.5 7282.7 7358.2 6437.9 6521.4 6561.3 6657.3 6667.9 5029.2 5034.9 5082.3 5121.0 5166.6 4985.0 5034.0 5141.5 5184.9 5244.9 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | [#4] prototype.html Cycles:180 Average:4314.65 Median:4779.90 stddev:1280.62 (26.8%) stddev-sans-first:1249.08 10:58:46 INFO - PROCESS | 2179 | Values: 345.6 346.9 359.9 365.6 367.7 4932.2 5123.2 5129.8 5139.0 5168.4 4891.7 4970.6 5030.1 5041.9 5064.8 3454.6 3867.5 4074.5 4087.1 4111.7 3177.8 4039.7 4080.2 4086.0 4096.4 3771.5 3846.5 3946.6 4055.4 4091.6 3368.9 3546.8 3573.0 4087.4 4088.6 3436.5 3582.7 3604.6 3610.2 3613.6 4405.8 4874.4 5033.4 5043.5 5117.6 4065.0 4343.0 4587.7 4616.8 4619.1 4492.6 5373.0 5392.6 5451.9 5454.8 3807.8 3957.4 3974.8 3975.2 3981.6 4961.7 5085.9 5267.4 5595.9 5671.6 3482.1 3850.9 4049.4 4061.9 4095.2 3490.8 3663.5 4137.6 4150.4 4155.3 4355.6 4584.6 4677.5 4685.2 4687.0 4432.5 5174.6 5416.4 5461.5 5471.8 1110.0 1156.9 1179.3 1192.9 1338.8 828.4 844.2 899.2 900.3 907.6 3726.5 4844.2 4902.0 4952.8 4972.2 5280.9 5362.4 5383.0 5401.4 5411.2 4520.0 4762.9 5096.9 5192.7 5218.2 2526.7 2756.4 2791.4 2806.7 2820.9 4941.2 5335.0 5481.6 5504.4 5601.9 4571.7 4574.4 4712.9 5531.3 5556.5 4647.0 4848.7 5027.5 5169.4 5576.9 4796.9 4817.8 5325.2 5349.4 5367.4 4374.6 4420.3 4627.4 5291.8 5316.6 5489.6 5534.7 5592.9 5594.9 5607.3 2953.1 3308.7 3566.0 3570.3 3589.3 4448.7 4577.7 4855.8 4919.4 5194.0 4302.4 4578.9 4848.6 5007.7 5139.7 4312.3 4423.5 5086.8 5115.6 5124.2 4529.6 5042.9 5345.8 5373.5 5398.3 5355.9 5472.3 5480.3 5480.3 5491.1 4715.7 5363.5 5368.2 5397.3 5415.1 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - PROCESS | 2179 | [#5] yui.html Cycles:180 Average:19848.44 Median:4346.12 stddev:28439.61 (654.4%) stddev-sans-first:28483.03 10:58:46 INFO - PROCESS | 2179 | Values: 697.4 703.5 735.4 761.3 789.0 14127.0 15112.4 15408.8 15427.4 15511.5 13715.9 13902.5 13922.8 13934.0 13936.8 677.4 701.1 704.0 852.0 855.1 871.4 875.5 881.4 884.9 889.9 936.2 938.5 939.8 939.8 941.1 932.9 933.2 934.0 934.4 935.4 526.5 547.0 666.4 685.5 695.4 14588.6 14640.3 14642.0 14647.5 14663.2 12104.5 12350.8 12428.2 12472.1 12582.5 12142.9 12177.3 12189.7 12226.2 12540.6 4275.4 4280.9 4387.2 4458.4 4479.6 85707.1 101288.5 103988.0 104627.0 107703.0 9288.9 10033.7 10351.3 10486.7 10811.4 20431.0 20570.5 20594.4 20680.9 20997.5 7464.9 7486.7 7509.1 7696.0 7735.6 4183.4 4269.1 4282.7 4296.8 4305.0 2896.6 3358.8 3409.6 3424.5 3455.5 631.6 639.9 641.2 642.4 646.6 579.5 614.5 616.6 619.1 629.9 8549.0 8632.4 8659.0 8790.0 8813.7 543.0 590.8 610.4 610.9 621.6 4265.4 4392.0 4396.3 4528.2 4604.3 104792.0 104874.4 105520.0 106188.5 108144.0 66606.0 76874.9 77107.0 77969.0 80497.0 76191.9 77770.0 78265.0 78768.2 78776.0 9691.0 9820.1 9820.9 9863.8 9868.3 32725.5 47077.0 50651.7 50954.7 51451.7 66612.7 67347.7 68103.0 70232.9 70233.0 13068.0 13128.9 13167.7 13207.7 13432.3 14560.6 14685.8 14920.9 14981.3 15270.0 13483.9 13626.1 13708.2 13778.7 14298.6 11206.8 13502.3 13687.7 13742.7 14017.4 13145.0 13765.3 13803.7 13824.2 13888.1 10805.4 11064.8 11110.0 11133.1 11160.4 9534.0 11149.8 11291.5 11436.8 11489.4 10:58:46 INFO - PROCESS | 2179 | -------- Summary: end -------- 10:58:46 INFO - PROCESS | 2179 | 10:58:46 INFO - TEST-INFO | 2179: exit 0 10:58:46 INFO - TEST-OK | dromaeo_css | took 1119855ms 10:58:46 INFO - TEST-START | kraken 10:58:46 INFO - operating with platform_type : mac_ 10:58:46 INFO - Initialising browser for kraken test... 10:58:46 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpOLq8dh/profile http://localhost:57136/getInfo.html) 10:58:49 INFO - PROCESS | 2182 | __metrics Screen width/height:1600/1200 10:58:49 INFO - PROCESS | 2182 | colorDepth:24 10:58:49 INFO - PROCESS | 2182 | Browser inner width/height: 1024/689 10:58:49 INFO - PROCESS | 2182 | __metrics 10:58:49 INFO - PROCESS | 2182 | 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" 10:58:49 INFO - PROCESS | 2182 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:58:50 INFO - TEST-INFO | 2182: exit 0 10:58:50 INFO - Browser initialized. 10:58:50 INFO - Running cycle 1/1 for kraken test... 10:58:50 INFO - TEST-INFO | started process 2183 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpOLq8dh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:02 INFO - PROCESS | 2183 | RSS: Main: 237092864 10:59:02 INFO - PROCESS | 2183 | 10:59:05 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57136/tests/kraken/driver.html?testName=audio-beat-detection) 10:59:06 INFO - PROCESS | 2183 | RSS: Main: 289566720 10:59:06 INFO - PROCESS | 2183 | 10:59:08 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57136/tests/kraken/driver.html?testName=audio-dft) 10:59:09 INFO - PROCESS | 2183 | RSS: Main: 290152448 10:59:09 INFO - PROCESS | 2183 | 10:59:13 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57136/tests/kraken/driver.html?testName=audio-fft) 10:59:13 INFO - PROCESS | 2183 | RSS: Main: 383016960 10:59:13 INFO - PROCESS | 2183 | 10:59:15 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57136/tests/kraken/driver.html?testName=audio-oscillator) 10:59:16 INFO - PROCESS | 2183 | RSS: Main: 284962816 10:59:16 INFO - PROCESS | 2183 | 10:59:18 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:59:18 INFO - PROCESS | 2183 | RSS: Main: 288215040 10:59:18 INFO - PROCESS | 2183 | 10:59:22 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57136/tests/kraken/driver.html?testName=imaging-darkroom) 10:59:22 INFO - PROCESS | 2183 | RSS: Main: 331513856 10:59:22 INFO - PROCESS | 2183 | 10:59:25 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57136/tests/kraken/driver.html?testName=imaging-desaturate) 10:59:26 INFO - PROCESS | 2183 | RSS: Main: 331010048 10:59:26 INFO - PROCESS | 2183 | 10:59:29 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57136/tests/kraken/driver.html?testName=json-parse-financial) 10:59:29 INFO - PROCESS | 2183 | RSS: Main: 328294400 10:59:29 INFO - PROCESS | 2183 | 10:59:31 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:59:32 INFO - PROCESS | 2183 | RSS: Main: 304840704 10:59:32 INFO - PROCESS | 2183 | 10:59:34 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:59:34 INFO - PROCESS | 2183 | RSS: Main: 309690368 10:59:34 INFO - PROCESS | 2183 | 10:59:36 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:59:37 INFO - PROCESS | 2183 | RSS: Main: 311341056 10:59:37 INFO - PROCESS | 2183 | 10:59:40 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:59:41 INFO - PROCESS | 2183 | RSS: Main: 323575808 10:59:41 INFO - PROCESS | 2183 | 10:59:44 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:59:45 INFO - PROCESS | 2183 | RSS: Main: 321323008 10:59:45 INFO - PROCESS | 2183 | 10:59:46 INFO - PROCESS | 2183 | Cycle 1(1): loaded http://localhost:57136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57136/tests/kraken/driver.html?testName=ai-astar) 10:59:47 INFO - PROCESS | 2183 | RSS: Main: 365481984 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | __start_tp_report 10:59:47 INFO - PROCESS | 2183 | _x_x_mozilla_page_load 10:59:47 INFO - PROCESS | 2183 | _x_x_mozilla_page_load_details 10:59:47 INFO - PROCESS | 2183 | |i|pagename|runs| 10:59:47 INFO - PROCESS | 2183 | |0;ai-astar;114;113;117;166;166;114;114;113;114;113 10:59:47 INFO - PROCESS | 2183 | |1;audio-beat-detection;150;114;113;152;116;113;124;145;136;116 10:59:47 INFO - PROCESS | 2183 | |2;audio-dft;185;185;184;185;177;265;212;183;187;186 10:59:47 INFO - PROCESS | 2183 | |3;audio-fft;83;59;62;88;63;58;59;60;78;58 10:59:47 INFO - PROCESS | 2183 | |4;audio-oscillator;90;69;87;72;68;69;83;69;69;83 10:59:47 INFO - PROCESS | 2183 | |5;imaging-gaussian-blur;109;111;111;110;109;111;109;113;113;170 10:59:47 INFO - PROCESS | 2183 | |6;imaging-darkroom;97;97;98;97;96;97;99;98;95;96 10:59:47 INFO - PROCESS | 2183 | |7;imaging-desaturate;84;83;87;87;86;99;117;128;130;83 10:59:47 INFO - PROCESS | 2183 | |8;json-parse-financial;56;53;53;54;55;55;54;56;54;54 10:59:47 INFO - PROCESS | 2183 | |9;json-stringify-tinderbox;65;78;89;115;113;73;71;71;71;71 10:59:47 INFO - PROCESS | 2183 | |10;stanford-crypto-aes;94;88;88;90;102;105;88;88;90;90 10:59:47 INFO - PROCESS | 2183 | |11;stanford-crypto-ccm;151;148;156;153;159;155;148;149;279;162 10:59:47 INFO - PROCESS | 2183 | |12;stanford-crypto-pbkdf2;178;179;174;205;182;177;176;179;180;178 10:59:47 INFO - PROCESS | 2183 | |13;stanford-crypto-sha256-iterative;70;67;68;69;69;69;69;66;69;68 10:59:47 INFO - PROCESS | 2183 | __end_tp_report 10:59:47 INFO - PROCESS | 2183 | __start_cc_report 10:59:47 INFO - PROCESS | 2183 | _x_x_mozilla_cycle_collect,1988 10:59:47 INFO - PROCESS | 2183 | __end_cc_report 10:59:47 INFO - PROCESS | 2183 | __startTimestamp1481655587158__endTimestamp 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | ------- Summary: start ------- 10:59:47 INFO - PROCESS | 2183 | Number of tests: 14 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#0] ai-astar Cycles:10 Average:124.40 Median:114.00 stddev:21.96 (19.3%) stddev-sans-first:22.96 10:59:47 INFO - PROCESS | 2183 | Values: 114.0 113.0 117.0 166.0 166.0 114.0 114.0 113.0 114.0 113.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:130.00 stddev:16.20 (12.5%) stddev-sans-first:15.08 10:59:47 INFO - PROCESS | 2183 | Values: 150.0 114.0 113.0 152.0 116.0 113.0 124.0 145.0 136.0 116.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#2] audio-dft Cycles:10 Average:194.90 Median:185.50 stddev:26.30 (14.2%) stddev-sans-first:27.65 10:59:47 INFO - PROCESS | 2183 | Values: 185.0 185.0 184.0 185.0 177.0 265.0 212.0 183.0 187.0 186.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#3] audio-fft Cycles:10 Average:66.80 Median:62.50 stddev:11.54 (18.5%) stddev-sans-first:10.64 10:59:47 INFO - PROCESS | 2183 | Values: 83.0 59.0 62.0 88.0 63.0 58.0 59.0 60.0 78.0 58.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:77.50 stddev:8.76 (11.3%) stddev-sans-first:7.66 10:59:47 INFO - PROCESS | 2183 | Values: 90.0 69.0 87.0 72.0 68.0 69.0 83.0 69.0 69.0 83.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:111.00 stddev:18.82 (17.0%) stddev-sans-first:19.76 10:59:47 INFO - PROCESS | 2183 | Values: 109.0 111.0 111.0 110.0 109.0 111.0 109.0 113.0 113.0 170.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:97.00 stddev:1.15 (1.2%) stddev-sans-first:1.22 10:59:47 INFO - PROCESS | 2183 | Values: 97.0 97.0 98.0 97.0 96.0 97.0 99.0 98.0 95.0 96.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:85.00 stddev:19.20 (22.6%) stddev-sans-first:19.64 10:59:47 INFO - PROCESS | 2183 | Values: 84.0 83.0 87.0 87.0 86.0 99.0 117.0 128.0 130.0 83.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.07 (2.0%) stddev-sans-first:0.97 10:59:47 INFO - PROCESS | 2183 | Values: 56.0 53.0 53.0 54.0 55.0 55.0 54.0 56.0 54.0 54.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:71.00 stddev:18.16 (25.6%) stddev-sans-first:18.23 10:59:47 INFO - PROCESS | 2183 | Values: 65.0 78.0 89.0 115.0 113.0 73.0 71.0 71.0 71.0 71.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:89.00 stddev:6.22 (7.0%) stddev-sans-first:6.57 10:59:47 INFO - PROCESS | 2183 | Values: 94.0 88.0 88.0 90.0 102.0 105.0 88.0 88.0 90.0 90.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#11] stanford-crypto-ccm Cycles:10 Average:166.00 Median:155.50 stddev:39.98 (25.7%) stddev-sans-first:42.04 10:59:47 INFO - PROCESS | 2183 | Values: 151.0 148.0 156.0 153.0 159.0 155.0 148.0 149.0 279.0 162.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:179.00 stddev:8.78 (4.9%) stddev-sans-first:9.25 10:59:47 INFO - PROCESS | 2183 | Values: 178.0 179.0 174.0 205.0 182.0 177.0 176.0 179.0 180.0 178.0 10:59:47 INFO - PROCESS | 2183 | 10:59:47 INFO - PROCESS | 2183 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.17 (1.7%) stddev-sans-first:1.09 10:59:47 INFO - PROCESS | 2183 | Values: 70.0 67.0 68.0 69.0 69.0 69.0 69.0 66.0 69.0 68.0 10:59:47 INFO - PROCESS | 2183 | -------- Summary: end -------- 10:59:47 INFO - PROCESS | 2183 | 10:59:48 INFO - TEST-INFO | 2183: exit 0 10:59:48 INFO - TEST-OK | kraken | took 61385ms 10:59:48 INFO - SUITE-END | took 1181s 10:59:48 INFO - Completed test suite (00:19:41) 10:59:48 INFO - javascript benchmark 10:59:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.198556353693, 3281.8194999275047, 3295.5880514935616, 3312.27130031393, 3346.1634591352163, 5471.206675032118, 5539.833804985852, 5589.944100558993, 5604.355499117602, 5631.239782629344, 5568.99758043553, 5584.21820945068, 5592.217089607448, 5597.496225339719, 5624.746886390112, 5048.368953880756, 5086.745662716868, 5099.209622508517, 5129.281900533928, 5190.896182076375, 5099.388073431193, 5120.385553733558, 5183.766730497118, 5184.092783762845, 5189.974050129763, 5089.796408143669, 5101.107306221415, 5111.258867464216, 5127.897442051157, 5147.459516750743, 5188.740562971836, 5190.948090519084, 5208.166693329049, 5212.374515058179, 5252.71110088945, 5002.24966255061, 5008.073506401291, 5057.393112826448, 5152.433232344477, 5155.61332900034, 4470.821167153343, 5521.199426083235, 5562.249096371978, 5582.469665381782, 5618.01684705179, 6124.2957059938235, 6131.724072416752, 6133.386661333876, 6134.8159555213415, 6140.723667434976, 4940.55535001848, 6040.758369665208, 6122.969385153046, 6228.657423841732, 6243.594166379171, 5585.553155747531, 5592.804251851166, 5632.9436705632825, 5639.605227634108, 5684.289463817023, 6296.779612713533, 6297.559170857996, 6321.431071203522, 6327.810165695037, 6333.683315834282, 5826.82519524415, 5939.792107276225, 5951.077582974646, 5952.642841429528, 5956.672383018976, 6076.422739839708, 6101.481374083164, 6103.186149163621, 6107.633541987495, 6178.752849885954, 4953.6037117030555, 6069.089636554464, 6076.939230607726, 6091.756329746849, 6129.1419201311855, 6094.207752992172, 6104.175936248638, 6108.114323423168, 6116.969415152896, 6124.448799608057, 4740.3837501124635, 4836.637252206028, 4840.201366774513, 4849.830255941025, 4851.708897466164, 4343.565643435694, 4380.452443444569, 4388.385626012361, 4393.253146965024, 4410.07388448423, 5635.915461268084, 5678.829635110953, 5694.032014557535, 5711.371749107595, 5730.111832665943, 6143.692815359214, 6201.255849298113, 6202.41077097675, 6208.286047104551, 6215.65813880241, 5538.390777014525, 5590.329160500766, 5591.524720398812, 5680.744366503517, 5688.345840228427, 5230.137027390514, 5295.655782374133, 5296.523312901857, 5341.4925582069645, 5356.91964620531, 6275.297604248513, 6351.301356850743, 6351.364863513704, 6358.078078678565, 6364.936350636434, 6113.14415981754, 6152.569320147547, 6160.784372546939, 6170.444659980623, 6181.690915454299, 6175.320714721467, 6235.625862448268, 6245.313015568375, 6293.37066293367, 6293.905591416041, 6049.243844519435, 6059.303180134341, 6060.030395136757, 6077.6961151943115, 6081.483073938588, 5905.379935106752, 5916.26046744157, 5967.6419414835245, 5968.432998865101, 6172.259328880563, 5716.171155182558, 5802.854928626818, 5819.6508209507565, 5963.940360596339, 5963.970180149072, 5810.244668193108, 5830.067189249699, 5862.970685146547, 5906.734196961061, 6004.849878753066, 5820.359760426434, 5824.650520968756, 5829.883402332014, 5843.094320380348, 5848.122781582797, 5902.291724993029, 5998.7300571473515, 6001.189839371804, 6016.909746353896, 6017.819465416044, 5642.210090587239, 5675.545956323402, 5683.976884160891, 5800.6809625471005, 5801.3038435388025], "value": 5583.250091946356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.27190136275163, 444.35790283041, 468.0335108001976, 485.3665965914481, 504.3267238236954, 30220.395592088145, 39116.41325380118, 40432.19135617286, 40512.79743601285, 40699.18601627966, 41466.58533414665, 41569.37645935306, 42013.57986420143, 42063.57936420635, 42101.57898421015, 8366.53187309745, 9300.209482194005, 9497.572609232566, 9514.762130946747, 9530.523473826315, 8478.152184781535, 11117.444127793618, 11379.772404551904, 11505.367204803733, 11548.3648399338, 11315.773684526304, 11358.091352691807, 11371.31772093673, 11380.71548211293, 11435.714107147305, 11245.381504017276, 11320.377379244139, 11337.829932551018, 11344.943275283571, 11351.716207094847, 11176.720581985433, 11248.606298779503, 11263.66209013731, 11265.71835704114, 11281.717957051058, 38941.22117557633, 39272.80363598164, 39284.41073383902, 39308.213835723414, 39335.0, 3273.312604353089, 3334.6998770110563, 3381.2561236527927, 3460.2560449503476, 3474.818561689038, 27612.585811212848, 27755.306117347027, 28537.286567835763, 28815.85592072047, 28870.566941495894, 3065.6321241450946, 3220.146661134801, 3275.395056422336, 3281.5241789940565, 3293.1602441377536, 436415.0, 437555.0, 437609.0, 437659.0, 438848.9999999968, 53449.0, 54139.72930135324, 54578.72710636421, 54579.0, 54597.0, 57296.0, 57488.712556437786, 57555.0, 57589.848203035705, 57606.0, 14825.70348593022, 15072.623184420258, 15082.360586897468, 15087.622809429851, 15091.698166036836, 10556.683299501028, 10828.566857325777, 11600.6519804406, 11696.649100526998, 11744.412779360997, 16566.75749318806, 16657.881760835262, 20659.4835129123, 21117.944102794798, 21142.57714845725, 7048.259932707095, 7671.6164191790185, 8169.918300816916, 8383.574792285326, 8402.537860417735, 864.9221570058725, 932.9923682422967, 987.481572174614, 1026.609888242463, 1044.5821671331528, 26278.868605656848, 28670.0, 30394.1369380898, 31613.0, 32125.839370802998, 1075.8117329467311, 1075.9623413180502, 1111.1777284809345, 1175.7060734816296, 1208.2327721896659, 11565.363904985306, 14034.598769732995, 15272.423381701086, 15775.605609859846, 16061.518154455385, 419226.0, 530999.0, 532411.0, 535144.0, 535649.0, 58924.11613825796, 59493.373460847935, 59540.40459595435, 59590.0, 59797.0, 1269.6444995401303, 1312.757139929097, 1394.8256467941508, 1399.2863639543702, 1437.6190309567974, 24461.755382445946, 29226.0, 30396.392072158877, 30461.847690761406, 31859.20351991126, 49913.251301231234, 50578.747106264236, 50662.2400663983, 50736.74631626818, 50904.74547627238, 552356.0, 557042.0, 557904.0, 557982.0, 558550.0, 36848.44727329039, 37925.62074379331, 38095.0, 38925.61074389333, 39228.607713922494, 41430.792846035576, 41713.79143104265, 42215.366769499095, 42238.366424503045, 42465.575344246165, 30419.0, 33745.66254337425, 34859.82570087133, 35284.47073293851, 36122.277554448236, 34321.65678343185, 34874.0, 35689.1077723059, 35739.82130089333, 35866.0, 34288.828555857064, 34797.652023480456, 35116.29767404689, 35333.0, 35706.0, 30543.847280763453, 31291.061268161993, 31396.686033139376, 31520.36959260756, 31680.5247921286, 23701.762982369957, 29837.0, 31381.8430907844, 32433.675663243066, 32523.674763252064], "value": 19802.7075007224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.12394575534046, 370.69973321609496, 371.69520992785925, 379.79491074819606, 394.94470774091633, 11505.4822532986, 14904.701905961874, 15572.688546229068, 20032.899835500837, 20425.28511502098, 18917.337893173742, 19159.425217243504, 19761.505962350948, 20006.399808005746, 20026.09882555285, 5745.971270143644, 6085.300190478085, 6085.5435842312, 6085.878282434349, 6093.451589356957, 4619.2609182530805, 6059.757609695607, 6082.908756368636, 6085.878282434349, 6089.604175728564, 5597.972010139964, 6005.759769609211, 6018.759249630009, 6021.759129634809, 6022.939770602304, 5824.388439213864, 5841.094630332305, 5893.263342082239, 5906.084556893688, 5913.2608423947, 5141.331626888481, 5144.794208231666, 5160.0969830279555, 6918.273581273944, 7308.6345682715655, 26265.212043638723, 26366.73633263662, 26564.601530977052, 26860.194194174204, 27051.729482705316, 2109.282843833104, 2400.23192578375, 2518.3704073981503, 2540.7840333571485, 2969.9902033308776, 14679.853201467955, 15764.265930747608, 16219.51341459758, 16284.26720797567, 16947.83052169475, 1709.5127888551704, 1827.41522712732, 2024.2206750401053, 2024.979750202494, 2027.1485975890162, 125149.0, 134283.98574021398, 134304.0, 135381.0, 136631.0, 9124.224440922464, 9691.51542422876, 9695.90304096964, 9815.75460613476, 9844.280832494835, 11826.408679566159, 11838.0, 12250.44872980718, 12274.509019639294, 12385.256884586774, 7512.948187253789, 7652.273034061755, 7818.413618978486, 7878.487898286593, 7945.920540794518, 7086.503944723923, 7813.609319534001, 8140.982377202849, 8253.050899146554, 8275.95862020686, 3800.410936304877, 3802.980985095057, 3807.371783655721, 3878.864239751595, 3897.707671924617, 1857.3499275253823, 1945.1538580717433, 1945.4455480188078, 1957.6476234277682, 1958.8432925365937, 810.5825499867573, 895.0735988252128, 926.5876684875301, 948.8956214816365, 952.7808604021114, 19271.807281927002, 19949.900250498944, 20110.095045722977, 20330.593388132154, 20375.008662422893, 840.7813968368268, 928.6331898899897, 965.8792650918635, 975.317277905469, 1020.9688214903001, 9079.500627465553, 9161.49611771359, 10820.621278255223, 10881.455927203608, 10903.400312982862, 492016.0, 494484.0, 498647.0, 515374.0, 517110.0, 108020.8395832079, 117398.23902641467, 119543.2068518973, 119654.4017279908, 125450.0, 966.9951650241563, 972.9659461918799, 984.0, 985.8521221816785, 1012.3925644613173, 14294.571162865132, 17453.127343633023, 17538.82461175372, 17675.64648706993, 17764.0, 50368.74815625898, 50657.73355666138, 50783.74608127084, 51713.0, 51869.0, 59842.0, 72224.0, 72695.1826204349, 80856.0, 82947.5852620733, 6582.703778329891, 6590.978398348264, 6702.899456508058, 7185.425165986604, 7331.193568707331, 9104.13510716481, 12236.755264894475, 12587.74824503523, 12730.618081457571, 12914.771307173207, 10845.511951962022, 10912.072473839495, 10942.288751231144, 11130.721731956766, 11277.492512836778, 10506.474676266309, 10647.361158330525, 10685.465726713477, 10809.135269178603, 11192.496337664987, 8825.646974120964, 11001.064909482784, 11520.827187592025, 11553.942230288794, 11655.650330490098, 6576.506761992965, 6761.695723692544, 7315.341619254293, 7459.0, 7538.811529711582, 9287.674931377369, 10203.132733717717, 10742.83885741699, 11025.944870275598, 11048.392338421463], "value": 9270.904133964106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.5998030580977, 1481.4740767027704, 1507.163524244044, 1708.8803783735136, 1886.594382207826, 6602.570832895864, 7461.253874612536, 7839.960800195998, 8362.540060296682, 8383.538905360203, 8221.6300266488, 8223.054348749896, 8248.91751082489, 8325.542095184763, 8331.958340208306, 2060.186226440555, 2275.5790178816887, 2316.085146367184, 2317.640765681322, 2322.001539338084, 2138.2088627207954, 2266.9659955100688, 2336.544373847092, 2339.982107783111, 2357.422431504275, 1922.7598199161532, 2315.710536182977, 2316.6872472216205, 2321.3964369263945, 2324.465372964219, 2273.1930164791424, 2295.850769699964, 2299.172158134287, 2305.0664480885184, 2306.2504685976955, 2281.4296425893526, 2313.306008197534, 2316.1893337331967, 2320.7795259450327, 2328.080408238753, 8227.83544329116, 8237.50574965504, 8299.128591497927, 8349.332053435772, 8366.037905640807, 5016.598672106223, 5191.974040129813, 5195.766190521435, 5201.765920533585, 5207.661502002357, 3310.7185889199445, 3465.3935561276676, 3522.788632682047, 3544.220271540257, 3560.305740380627, 998.4209158687944, 1032.6695457453618, 1076.2896488317751, 1082.837574363844, 1085.0776839686282, 10418.27072104953, 10671.092957098655, 10763.515641796137, 10763.838542421792, 10815.567377304898, 4314.676399270067, 4393.7363758174615, 4439.578240067189, 4442.244818380883, 4450.087732014929, 8638.0, 8639.568021599021, 8647.135286471303, 8660.566971651393, 8680.913190868137, 5049.596032317406, 5065.11360511909, 5073.670211436245, 5081.822136225214, 5085.0, 4241.660667146621, 4405.449318835145, 4683.461401938753, 4685.461171965268, 4713.010267843722, 3382.6279109297957, 3533.3993221152464, 3643.2349206666368, 3646.9759283597327, 3649.635036496329, 969.4280374579032, 997.5610731278215, 998.8052329795765, 1003.9609004680121, 1007.2797949466167, 789.8341348316803, 844.5819319436795, 850.8681154421074, 881.8809460722848, 937.329809186435, 5355.598330125178, 5420.105682562333, 5527.474889885454, 5570.610057296031, 5682.602217844711, 812.7764864662147, 898.3217670658611, 904.6019751309403, 907.7095329494631, 933.8459154239611, 3772.3398405278967, 3833.4441505982036, 3834.386498160281, 3857.9614203858164, 3861.575226725058, 9466.90533094674, 9997.600095996224, 10126.189904807597, 10148.441835698959, 10158.13655839262, 10068.949655251678, 10082.193424526167, 10090.0, 10091.142252908438, 10113.747156321004, 7326.157491888501, 7641.0, 7802.453828231969, 7848.960755196187, 7920.5247685139075, 5707.229524014205, 5807.535397168132, 5842.357340692605, 5945.197398351167, 5976.850578735566, 8907.0, 9197.172254497127, 9205.723828285161, 9301.860572068597, 9331.486768227813, 9279.211267042378, 9280.164785169367, 9355.158035776813, 9392.154706076486, 9510.0, 7090.326418990187, 7108.147022357351, 7172.713091476491, 7272.272772722686, 7280.563166210044, 7162.140543134648, 7442.776716698508, 7464.925350746423, 7640.80897977555, 8002.079760827346, 7228.241034691492, 7373.18894921569, 7401.59291238987, 7447.0, 7512.0, 7251.311125443074, 7270.527415717961, 7281.490295679251, 7282.6722797473185, 7358.190599033995, 6437.903431448438, 6521.380468855451, 6561.311062338385, 6657.3342665733035, 6667.933320666732, 5029.220470827027, 5034.899302014012, 5082.263071854486, 5121.0, 5166.560842328444, 4985.0, 5034.018366418513, 5141.511556402136, 5184.870378240575, 5244.921326180034], "value": 4358.775095477733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6422602606303, 346.93234819210255, 359.92081742016757, 365.5978423733893, 367.7480925565989, 4932.161532539468, 5123.231515272711, 5129.794808207676, 5139.0, 5168.405633352161, 4891.657583969123, 4970.577500912426, 5030.132824290156, 5041.873953151164, 5064.84805455836, 3454.616314742832, 3867.458555802176, 4074.5110586729484, 4087.1417002429525, 4111.691623128278, 3177.8093314401094, 4039.7172197946156, 4080.1839632073556, 4085.9785053736564, 4096.443351526415, 3771.4531392948006, 3846.499955005845, 3946.565877753445, 4055.3981177434894, 4091.5703851095654, 3368.865245390169, 3546.822658867059, 3572.964270357289, 4087.4073259377224, 4088.632023117934, 3436.536067630888, 3582.695470884978, 3604.6395360464007, 3610.205754733954, 3613.6205698401554, 4405.801738921724, 4874.3929492175885, 5033.375969302097, 5043.495650434964, 5117.5650069744115, 4064.9593504065174, 4342.956570434287, 4587.7017993830295, 4616.75347656131, 4619.145458090264, 4492.573205545468, 5372.973135134299, 5392.622516423852, 5451.863703407407, 5454.836354909319, 3807.7905715185652, 3957.3668213086057, 3974.8012599369918, 3975.15155452713, 3981.601839816024, 4961.668016032459, 5085.898282034339, 5267.367915850046, 5595.944040559583, 5671.574631902624, 3482.0946553895665, 3850.8844734658005, 4049.3521036633997, 4061.8578349757618, 4095.1809638072505, 3490.7730997485082, 3663.4504824276573, 4137.565555616678, 4150.3566947123245, 4155.340582027505, 4355.564443555619, 4584.564466375689, 4677.4854765975715, 4685.226937555333, 4686.953130468652, 4432.468103827497, 5174.593813876565, 5416.350037995387, 5461.5357694596405, 5471.823557935063, 1110.0342701849281, 1156.8611766588062, 1179.280638810325, 1192.8866757658009, 1338.8084604701824, 828.3662997806682, 844.1727107434625, 899.1862364560084, 900.2617853360182, 907.6340108137343, 3726.466003117906, 4844.224924012141, 4901.950980490221, 4952.77482256216, 4972.154733695281, 5280.940433231043, 5362.410134885159, 5382.973085134549, 5401.4102794590535, 5411.242426060355, 4519.966015293131, 4762.880927976828, 5096.898062038738, 5192.714400707997, 5218.243354713545, 2526.7473252674586, 2756.3798145417522, 2791.4269734739564, 2806.7052959439375, 2820.943581128407, 4941.160002799533, 5334.973325133349, 5481.643693159932, 5504.422035686275, 5601.8599535011135, 4571.702839315434, 4574.428196475441, 4712.88217794551, 5531.280933478622, 5556.527170518426, 4647.0, 4848.733319667452, 5027.497250274943, 5169.431362550116, 5576.86057848557, 4796.9280460792415, 4817.78319975595, 5325.245701780158, 5349.411564727799, 5367.3827509836865, 4374.628156606596, 4420.347791325179, 4627.352170696038, 5291.814786482609, 5316.6012549058205, 5489.615726899079, 5534.667919924817, 5592.888142237214, 5594.86012849682, 5607.299087614048, 2953.1344028415947, 3308.71875890552, 3565.982170089133, 3570.3216388887067, 3589.3000864831106, 4448.7108337957925, 4577.679562430598, 4855.75721213945, 4919.409670839379, 5194.013137503862, 4302.440682711227, 4578.939477235191, 4848.5636292732415, 5007.712236249014, 5139.743012849417, 4312.331588603772, 4423.469183697976, 5086.796528138833, 5115.641905066758, 5124.154514505065, 4529.592336689714, 5042.9409823937385, 5345.839624811262, 5373.5432488237375, 5398.299535646259, 5355.946440535545, 5472.34331880161, 5480.26016487785, 5480.314960629921, 5491.148871924858, 4715.740634265148, 5363.490468405495, 5368.215408137332, 5397.298351214317, 5415.106507426388], "value": 3922.8024569321947, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3653974882856, 703.4653663215954, 735.3896266099139, 761.3300295739748, 788.964496597653, 14127.0, 15112.395504179847, 15408.768868466968, 15427.382904683813, 15511.457099001536, 13715.862841371583, 13902.513412030581, 13922.791158132612, 13934.0, 13936.79094813576, 677.3903486861815, 701.1340993872564, 704.031956060417, 851.9914800852005, 855.1320409784074, 871.3813192633238, 875.5140896802272, 881.3786280672143, 884.8584226523758, 889.9110088991082, 936.2135805923024, 938.5494962418044, 939.7791518993031, 939.8026414452974, 941.1153515695258, 932.883389576303, 933.2347475070445, 934.042606328512, 934.4066517761203, 935.4480856294819, 526.5419085395692, 546.9917951230734, 666.4102269491535, 685.4550632247325, 695.3741632530712, 14588.635284117876, 14640.267986600735, 14642.048266862726, 14647.487337943227, 14663.193524356157, 12104.455299511543, 12350.81473777885, 12428.192167509083, 12472.126951113425, 12582.496700131984, 12142.939285303517, 12177.26936383811, 12189.695257618541, 12226.205296655779, 12540.623781286486, 4275.358696195564, 4280.850170244026, 4387.232234358974, 4458.420405347284, 4479.552044795527, 85707.14292857054, 101288.454904078, 103987.96012039934, 104627.0, 107703.0, 9288.90711092894, 10033.749156271151, 10351.275410721328, 10486.737831554272, 10811.35131892089, 20431.0, 20570.485737856376, 20594.38216853497, 20680.896595517228, 20997.475063123544, 7464.925350746532, 7486.663100160397, 7509.09890813095, 7696.037995250594, 7735.574543400055, 4183.412857114603, 4269.103488267437, 4282.721623094551, 4296.849610263625, 4305.0, 2896.6241035507965, 3358.815265160391, 3409.5908490980746, 3424.503447000171, 3455.4989526518516, 631.608402790273, 639.9072134540465, 641.2049059166693, 642.4025656139835, 646.5797231799368, 579.5334755521761, 614.5312702640692, 616.6269407008784, 619.1393962392189, 629.9149614802035, 8549.0, 8632.35257355701, 8658.956705216433, 8790.011396125348, 8813.667731022768, 542.9918551221734, 590.7755053079889, 610.4475449718012, 610.9419605137505, 621.564904566805, 4265.3815196796295, 4391.956080439219, 4396.340548917688, 4528.162289976365, 4604.286335617984, 104792.0, 104874.42688359528, 105520.0, 106188.46905765422, 108144.0, 66606.00090998542, 76874.92500300037, 77107.0, 77969.0, 80497.0, 76191.85712214433, 77770.0, 78265.0, 78768.18477228346, 78776.0, 9691.0, 9820.11618954269, 9820.852687209555, 9863.753406164617, 9868.309218354647, 32725.50911736278, 47077.0, 50651.746741266055, 50954.74522627363, 51451.71370715612, 66612.666936665, 67347.66326168338, 68103.0, 70232.94650580143, 70233.0, 13068.0, 13128.934355328161, 13167.67080822987, 13207.735845283232, 13432.261225632685, 14560.635984100481, 14685.779713304522, 14920.889944465911, 14981.250937453302, 15270.0, 13483.932580337036, 13626.1143025703, 13708.17750934947, 13778.65553361174, 14298.642533936734, 11206.83189752138, 13502.25737584403, 13687.726245475234, 13742.725145496834, 14017.439302427789, 13145.0, 13765.311734413439, 13803.654908627364, 13824.170549767046, 13888.097273677582, 10805.405702686428, 11064.778704426028, 11110.0, 11133.053690436403, 11160.441977901235, 9534.0, 11149.83275250888, 11291.548338066385, 11436.82844757346, 11489.368084755419], "value": 7319.291410336789, "unit": "score"}], "name": "dromaeo_css", "value": 7101.806462331695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 117.0, 166.0, 166.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 113.0, 152.0, 116.0, 113.0, 124.0, 145.0, 136.0, 116.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 185.0, 177.0, 265.0, 212.0, 183.0, 187.0, 186.0], "value": 194.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 62.0, 88.0, 63.0, 58.0, 59.0, 60.0, 78.0, 58.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 87.0, 72.0, 68.0, 69.0, 83.0, 69.0, 69.0, 83.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 110.0, 109.0, 111.0, 109.0, 113.0, 113.0, 170.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 98.0, 97.0, 96.0, 97.0, 99.0, 98.0, 95.0, 96.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 87.0, 87.0, 86.0, 99.0, 117.0, 128.0, 130.0, 83.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 55.0, 55.0, 54.0, 56.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 89.0, 115.0, 113.0, 73.0, 71.0, 71.0, 71.0, 71.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 88.0, 88.0, 90.0, 102.0, 105.0, 88.0, 88.0, 90.0, 90.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 156.0, 153.0, 159.0, 155.0, 148.0, 149.0, 279.0, 162.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 179.0, 174.0, 205.0, 182.0, 177.0, 176.0, 179.0, 180.0, 178.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 69.0, 69.0, 69.0, 69.0, 66.0, 69.0, 68.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1545.5, "alertThreshold": 2.0}]} 10:59:48 INFO - Return code: 0 10:59:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:59:48 INFO - # TBPL SUCCESS # 10:59:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:59:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:59:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:59:48 INFO - 2016-12-13 10:59:48.493 screenresolution[2187:30874] starting screenresolution argv=screenresolution get 10:59:48 INFO - 2016-12-13 10:59:48.496 screenresolution[2187:30874] Display 0: 1600x1200x32@60 10:59:48 INFO - 2016-12-13 10:59:48.502 screenresolution[2188:30877] starting screenresolution argv=screenresolution list 10:59:48 INFO - Available Modes on Display 0 10:59:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:59:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:59:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:59:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:59:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:59:48 INFO - Intel Iris: 10:59:48 INFO - Chipset Model: Intel Iris 10:59:48 INFO - Type: GPU 10:59:48 INFO - Bus: Built-In 10:59:48 INFO - VRAM (Dynamic, Max): 1536 MB 10:59:48 INFO - Vendor: Intel (0x8086) 10:59:48 INFO - Device ID: 0x0a2e 10:59:48 INFO - Revision ID: 0x0009 10:59:48 INFO - Displays: 10:59:48 INFO - Display: 10:59:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:59:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:59:48 INFO - Display Serial Number: 1600x1200 60 10:59:48 INFO - Main Display: Yes 10:59:48 INFO - Mirror: Off 10:59:48 INFO - Online: Yes 10:59:48 INFO - Rotation: Supported 10:59:48 INFO - Return code: 0 10:59:48 INFO - Running post-action listener: _resource_record_post_action 10:59:48 INFO - [mozharness: 2016-12-13 18:59:48.746884Z] Finished run-tests step (success) 10:59:48 INFO - Running post-run listener: _resource_record_post_run 10:59:48 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 516096; Write bytes: 551846912; Read time: 5; Write time: 2636 10:59:48 INFO - TinderboxPrint: CPU usage
53.7% 10:59:48 INFO - TinderboxPrint: I/O read bytes / time
516,096 / 5 10:59:48 INFO - TinderboxPrint: I/O write bytes / time
551,846,912 / 2,636 10:59:48 INFO - TinderboxPrint: CPU idle
2,228.2 (46.3%) 10:59:48 INFO - TinderboxPrint: CPU system
967.1 (20.1%) 10:59:48 INFO - TinderboxPrint: CPU user
1,622.3 (33.7%) 10:59:48 INFO - TinderboxPrint: Swap in / out
249,360,384 / 0 10:59:48 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250092032; Write bytes: 252147712; Read time: 18226; Write time: 506 10:59:48 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 479232; Write bytes: 298241024; Read time: 5; Write time: 1606 10:59:49 INFO - Running post-run listener: _upload_blobber_files 10:59:49 INFO - Blob upload gear active. 10:59:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:59:49 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 10:59:49 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'] 10:59:49 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 10:59:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:59:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:59:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:59:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:50 INFO - (blobuploader) - INFO - Done attempting. 10:59:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:59:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:59:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:51 INFO - (blobuploader) - INFO - Done attempting. 10:59:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:59:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:59:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:54 INFO - (blobuploader) - INFO - Done attempting. 10:59:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:59:54 INFO - Return code: 0 10:59:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:59:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:59:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64dab70e60e6279a58a2eca1243bafd0ff46526feb3abfeb94e18cf87a8e3773fb910ce1bfa5c70efc5b4d576f708dacfbf03cbd02a71dcfdf3b25a1447684d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102c0ea997bbfa2a6b9e0865be85fb33f8023d02c8002e760ac6e66b158d8f5840d4933d5f1049c0028a0a010b00fd7f2e877ebf81ff6cb3c56c77ade8e18386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245f5a2452b38466aedc214b88623be22d2a52c3c1c02ec87d68b237bb3368b2e99f000192e33d4729d0a71cff7711382aa83f879029e2a3844475a9255982ac"} 10:59:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:59:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:59:54 INFO - Contents: 10:59:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64dab70e60e6279a58a2eca1243bafd0ff46526feb3abfeb94e18cf87a8e3773fb910ce1bfa5c70efc5b4d576f708dacfbf03cbd02a71dcfdf3b25a1447684d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102c0ea997bbfa2a6b9e0865be85fb33f8023d02c8002e760ac6e66b158d8f5840d4933d5f1049c0028a0a010b00fd7f2e877ebf81ff6cb3c56c77ade8e18386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245f5a2452b38466aedc214b88623be22d2a52c3c1c02ec87d68b237bb3368b2e99f000192e33d4729d0a71cff7711382aa83f879029e2a3844475a9255982ac"} 10:59:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:59:54 INFO - Copying logs to upload dir... 10:59:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:59:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.741631 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-13 10:59:54.915259) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:54.918776) ========= 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.1J2BX6Z76C/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.A5nqghzL8q/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/64dab70e60e6279a58a2eca1243bafd0ff46526feb3abfeb94e18cf87a8e3773fb910ce1bfa5c70efc5b4d576f708dacfbf03cbd02a71dcfdf3b25a1447684d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102c0ea997bbfa2a6b9e0865be85fb33f8023d02c8002e760ac6e66b158d8f5840d4933d5f1049c0028a0a010b00fd7f2e877ebf81ff6cb3c56c77ade8e18386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245f5a2452b38466aedc214b88623be22d2a52c3c1c02ec87d68b237bb3368b2e99f000192e33d4729d0a71cff7711382aa83f879029e2a3844475a9255982ac"} build_url:https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/UGJO-DqNRi-fH_lWUqqQDQ/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/64dab70e60e6279a58a2eca1243bafd0ff46526feb3abfeb94e18cf87a8e3773fb910ce1bfa5c70efc5b4d576f708dacfbf03cbd02a71dcfdf3b25a1447684d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102c0ea997bbfa2a6b9e0865be85fb33f8023d02c8002e760ac6e66b158d8f5840d4933d5f1049c0028a0a010b00fd7f2e877ebf81ff6cb3c56c77ade8e18386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/245f5a2452b38466aedc214b88623be22d2a52c3c1c02ec87d68b237bb3368b2e99f000192e33d4729d0a71cff7711382aa83f879029e2a3844475a9255982ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:54.952525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:54.952830) ========= 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.1J2BX6Z76C/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.A5nqghzL8q/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005365 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:59:55.001295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:59:55.001611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:59:55.001924) ========= ========= Total master_lag: 0.36 =========