builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0007 starttime: 1486055398.78 results: success (0) buildid: 20170202073219 builduid: 360f8bdf83f54a64be4b8293c915a910 revision: cd8688f42f8a32f24906ef5de60000e2759546ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:58.779051) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:58.779531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:58.779814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:58.805258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:58.805638) ========= 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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-02 09:09:58-- 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% 9.21M=0.001s 2017-02-02 09:09:58 (9.21 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125594 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:58.955290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:58.955667) ========= 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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.025927 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:59.005623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:59.006170) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd8688f42f8a32f24906ef5de60000e2759546ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd8688f42f8a32f24906ef5de60000e2759546ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8NPtBxXfJr/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.DI6qmp4eLa/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-02 09:09:59,114 truncating revision to first 12 chars 2017-02-02 09:09:59,114 Setting DEBUG logging. 2017-02-02 09:09:59,114 attempt 1/10 2017-02-02 09:09:59,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cd8688f42f8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 09:09:59,812 unpacking tar archive at: mozilla-aurora-cd8688f42f8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.963958 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:59.997237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:59.997684) ========= script_repo_revision: cd8688f42f8a32f24906ef5de60000e2759546ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:59.998072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 09:09:59.998353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 09:10:00.018369) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-02 09:10:00.018752) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8NPtBxXfJr/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.DI6qmp4eLa/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:00 INFO - MultiFileLogger online at 20170202 09:10:00 in /builds/slave/test 09:10:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:10:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:00 INFO - {'append_to_log': False, 09:10:00 INFO - 'base_work_dir': '/builds/slave/test', 09:10:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:10:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:00 INFO - 'branch': 'Mozilla-Aurora', 09:10:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:00 INFO - 'config_files': ('talos/mac_config.py',), 09:10:00 INFO - 'default_actions': ('clobber', 09:10:00 INFO - 'read-buildbot-config', 09:10:00 INFO - 'download-and-extract', 09:10:00 INFO - 'populate-webroot', 09:10:00 INFO - 'create-virtualenv', 09:10:00 INFO - 'install', 09:10:00 INFO - 'run-tests'), 09:10:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:00 INFO - 'download_minidump_stackwalk': True, 09:10:00 INFO - 'download_symbols': 'ondemand', 09:10:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:00 INFO - 'installer_path': 'installer.exe', 09:10:00 INFO - 'log_level': 'info', 09:10:00 INFO - 'log_name': 'talos', 09:10:00 INFO - 'log_to_console': True, 09:10:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:10:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:10:00 INFO - 'opt_config_files': (), 09:10:00 INFO - 'pip_index': False, 09:10:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:10:00 INFO - 'cmd': ('bash', 09:10:00 INFO - '-c', 09:10:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:10:00 INFO - 'enabled': True, 09:10:00 INFO - 'halt_on_failure': False, 09:10:00 INFO - 'name': 'check_screen_resolution'},), 09:10:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:10:00 INFO - 'cmd': ('bash', 09:10:00 INFO - '-c', 09:10:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:10:00 INFO - 'enabled': True, 09:10:00 INFO - 'halt_on_failure': False, 09:10:00 INFO - 'name': 'check_screen_resolution'},), 09:10:00 INFO - 'run_cmd_checks_enabled': True, 09:10:00 INFO - 'sps_profile': False, 09:10:00 INFO - 'sps_profile_interval': 0, 09:10:00 INFO - 'suite': 'dromaeojs', 09:10:00 INFO - 'system_bits': '32', 09:10:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:00 INFO - 'title': 't-yosemite-r7-0007', 09:10:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:00 INFO - 'use_talos_json': True, 09:10:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:00 INFO - 'work_dir': 'build'} 09:10:00 INFO - [mozharness: 2017-02-02 17:10:00.233255Z] Running clobber step. 09:10:00 INFO - Running pre-action listener: _resource_record_pre_action 09:10:00 INFO - Running main action method: clobber 09:10:00 INFO - rmtree: /builds/slave/test/build 09:10:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:02 INFO - Running post-action listener: _resource_record_post_action 09:10:02 INFO - [mozharness: 2017-02-02 17:10:02.812676Z] Finished clobber step (success) 09:10:02 INFO - [mozharness: 2017-02-02 17:10:02.812915Z] Running read-buildbot-config step. 09:10:02 INFO - Running pre-action listener: _resource_record_pre_action 09:10:02 INFO - Running main action method: read_buildbot_config 09:10:02 INFO - Using buildbot properties: 09:10:02 INFO - { 09:10:02 INFO - "project": "", 09:10:02 INFO - "product": "firefox", 09:10:02 INFO - "script_repo_revision": "production", 09:10:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:10:02 INFO - "repository": "", 09:10:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:10:02 INFO - "buildid": "20170202073219", 09:10:02 INFO - "pgo_build": "False", 09:10:02 INFO - "basedir": "/builds/slave/test", 09:10:02 INFO - "buildnumber": 54, 09:10:02 INFO - "slavename": "t-yosemite-r7-0007", 09:10:02 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:10:02 INFO - "platform": "yosemite_r7", 09:10:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:10:02 INFO - "branch": "mozilla-aurora", 09:10:02 INFO - "repo_path": "releases/mozilla-aurora", 09:10:02 INFO - "revision": "cd8688f42f8a32f24906ef5de60000e2759546ea", 09:10:02 INFO - "stage_platform": "macosx64", 09:10:02 INFO - "builduid": "360f8bdf83f54a64be4b8293c915a910", 09:10:02 INFO - "slavebuilddir": "test" 09:10:02 INFO - } 09:10:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:10:02 INFO - Running post-action listener: _resource_record_post_action 09:10:02 INFO - [mozharness: 2017-02-02 17:10:02.818791Z] Finished read-buildbot-config step (success) 09:10:02 INFO - [mozharness: 2017-02-02 17:10:02.819024Z] Running download-and-extract step. 09:10:02 INFO - Running pre-action listener: _resource_record_pre_action 09:10:02 INFO - Running main action method: download_and_extract 09:10:02 INFO - mkdir: /builds/slave/test/build/tests 09:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:02 INFO - trying https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:10:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:10:04 INFO - Downloaded 1199 bytes. 09:10:04 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:10:04 INFO - Using the following test package requirements: 09:10:04 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:10:04 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:10:04 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:10:04 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'jsshell-mac.zip'], 09:10:04 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:10:04 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:10:04 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:10:04 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:10:04 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:10:04 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:10:04 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:10:04 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:10:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:10:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:10:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:10:05 INFO - Expected file size: 16355950 09:10:05 INFO - Obtained file size: 16355950 09:10:11 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:10:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:10:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:10:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:10:12 INFO - Expected file size: 16355950 09:10:12 INFO - Obtained file size: 16355950 09:10:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:10:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:10:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:10:20 INFO - Expected file size: 14403485 09:10:20 INFO - Obtained file size: 14403485 09:10:20 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')]} 09:10:20 INFO - trying https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:10:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:10:23 INFO - Downloaded 73824821 bytes. 09:10:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:10:23 INFO - mkdir: /builds/slave/test/properties 09:10:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:10:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:10:23 INFO - Contents: 09:10:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:10:23 INFO - Running post-action listener: _resource_record_post_action 09:10:23 INFO - Running post-action listener: set_extra_try_arguments 09:10:23 INFO - [mozharness: 2017-02-02 17:10:23.870533Z] Finished download-and-extract step (success) 09:10:23 INFO - [mozharness: 2017-02-02 17:10:23.870680Z] Running populate-webroot step. 09:10:23 INFO - Running pre-action listener: _resource_record_pre_action 09:10:23 INFO - Running main action method: populate_webroot 09:10:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:10:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:10:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:10:23 INFO - '--tppagecycles', 09:10:23 INFO - '7'], 09:10:23 INFO - 'tests': ['tsvgm']}}, 09:10:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:10:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:10:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:10:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:10:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:10:23 INFO - 'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:10:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:10:23 INFO - 'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['damp', 'tps']}, 09:10:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:10:23 INFO - 'tests': ['damp', 'tps']}, 09:10:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['dromaeo_dom']}, 09:10:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:10:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['basic_compositor_video']}, 09:10:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:10:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['a11yr', 09:10:23 INFO - 'ts_paint', 09:10:23 INFO - 'tpaint', 09:10:23 INFO - 'sessionrestore', 09:10:23 INFO - 'sessionrestore_no_auto_restore', 09:10:23 INFO - 'tabpaint']}, 09:10:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:10:23 INFO - 'ts_paint', 09:10:23 INFO - 'tpaint', 09:10:23 INFO - 'sessionrestore', 09:10:23 INFO - 'sessionrestore_no_auto_restore', 09:10:23 INFO - 'tabpaint']}, 09:10:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:10:23 INFO - 'ts_paint', 09:10:23 INFO - 'tpaint', 09:10:23 INFO - 'sessionrestore', 09:10:23 INFO - 'sessionrestore_no_auto_restore', 09:10:23 INFO - 'tabpaint']}, 09:10:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:10:23 INFO - 'ts_paint', 09:10:23 INFO - 'tpaint', 09:10:23 INFO - 'sessionrestore', 09:10:23 INFO - 'sessionrestore_no_auto_restore', 09:10:23 INFO - 'tabpaint']}, 09:10:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['a11yr', 09:10:23 INFO - 'ts_paint', 09:10:23 INFO - 'tpaint', 09:10:23 INFO - 'sessionrestore', 09:10:23 INFO - 'sessionrestore_no_auto_restore', 09:10:23 INFO - 'tabpaint']}, 09:10:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['a11yr', 09:10:23 INFO - 'ts_paint', 09:10:23 INFO - 'tpaint', 09:10:23 INFO - 'sessionrestore', 09:10:23 INFO - 'sessionrestore_no_auto_restore', 09:10:23 INFO - 'tabpaint']}, 09:10:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['tsvgx', 09:10:23 INFO - 'tsvgr_opacity', 09:10:23 INFO - 'tart', 09:10:23 INFO - 'tscrollx', 09:10:23 INFO - 'cart', 09:10:23 INFO - 'tsvg_static']}, 09:10:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:10:23 INFO - 'tsvgr_opacity', 09:10:23 INFO - 'tart', 09:10:23 INFO - 'tscrollx', 09:10:23 INFO - 'cart', 09:10:23 INFO - 'tsvg_static']}, 09:10:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:10:23 INFO - 'talos_options': ['--disable-e10s'], 09:10:23 INFO - 'tests': ['tp5o']}, 09:10:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:10:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:10:23 INFO - 'talos_options': ['--disable-e10s', 09:10:23 INFO - '--xperf_path', 09:10:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:23 INFO - 'tests': ['tp5n']}, 09:10:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:10:23 INFO - 'talos_options': ['--xperf_path', 09:10:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:23 INFO - 'tests': ['tp5n']}}, 09:10:23 INFO - 'talos.zip': {'path': '', 09:10:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:10:23 INFO - Running post-action listener: _resource_record_post_action 09:10:23 INFO - [mozharness: 2017-02-02 17:10:23.889675Z] Finished populate-webroot step (success) 09:10:23 INFO - [mozharness: 2017-02-02 17:10:23.889808Z] Running create-virtualenv step. 09:10:23 INFO - Running pre-action listener: _resource_record_pre_action 09:10:23 INFO - Running main action method: create_virtualenv 09:10:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:10:23 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 09:10:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:10:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:10:24 INFO - Using real prefix '/tools/python27' 09:10:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:10:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:10:27 INFO - Installing pip.................done. 09:10:27 INFO - Return code: 0 09:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:10:27 INFO - Reading from file tmpfile_stdout 09:10:27 INFO - Output received: 09:10:27 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) 09:10:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:27 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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:27 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 09:10:27 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 09:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:27 INFO - 'HOME': '/Users/cltbld', 09:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:27 INFO - 'LOGNAME': 'cltbld', 09:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:27 INFO - 'MOZ_NO_REMOTE': '1', 09:10:27 INFO - 'NO_EM_RESTART': '1', 09:10:27 INFO - 'PAGER': '/bin/cat', 09:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:27 INFO - 'PWD': '/builds/slave/test', 09:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:27 INFO - 'SHELL': '/bin/bash', 09:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:27 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:27 INFO - 'USER': 'cltbld', 09:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:27 INFO - 'XPC_FLAGS': '0x0', 09:10:27 INFO - 'XPC_SERVICE_NAME': '0', 09:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:28 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 09:10:28 INFO - Cleaning up... 09:10:28 INFO - Return code: 0 09:10:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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', '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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:10: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 psutil>=3.1.1 09:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:28 INFO - 'HOME': '/Users/cltbld', 09:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:28 INFO - 'LOGNAME': 'cltbld', 09:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:28 INFO - 'MOZ_NO_REMOTE': '1', 09:10:28 INFO - 'NO_EM_RESTART': '1', 09:10:28 INFO - 'PAGER': '/bin/cat', 09:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:28 INFO - 'PWD': '/builds/slave/test', 09:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:28 INFO - 'SHELL': '/bin/bash', 09:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:28 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:28 INFO - 'USER': 'cltbld', 09:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:28 INFO - 'XPC_FLAGS': '0x0', 09:10:28 INFO - 'XPC_SERVICE_NAME': '0', 09:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:28 INFO - Downloading/unpacking psutil>=3.1.1 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:31 INFO - Installing collected packages: psutil 09:10:31 INFO - Running setup.py install for psutil 09:10:31 INFO - building 'psutil._psutil_osx' extension 09:10:31 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 09:10:32 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 09:10:32 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 09:10:32 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 09:10:32 INFO - building 'psutil._psutil_posix' extension 09:10:32 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 09:10:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:10:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:10:32 INFO - ^ 09:10:32 INFO - 1 warning generated. 09:10:32 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 09:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:33 INFO - Successfully installed psutil 09:10:33 INFO - Cleaning up... 09:10:33 INFO - Return code: 0 09:10:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:33 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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:33 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 09:10:33 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 09:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:33 INFO - 'HOME': '/Users/cltbld', 09:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:33 INFO - 'LOGNAME': 'cltbld', 09:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:33 INFO - 'MOZ_NO_REMOTE': '1', 09:10:33 INFO - 'NO_EM_RESTART': '1', 09:10:33 INFO - 'PAGER': '/bin/cat', 09:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:33 INFO - 'PWD': '/builds/slave/test', 09:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:33 INFO - 'SHELL': '/bin/bash', 09:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:33 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:33 INFO - 'USER': 'cltbld', 09:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:33 INFO - 'XPC_FLAGS': '0x0', 09:10:33 INFO - 'XPC_SERVICE_NAME': '0', 09:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:10:33 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 09:10:33 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 09:10:33 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 09:10:33 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 09:10:33 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 09:10:33 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 09:10:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:10:36 INFO - Installing collected packages: mozsystemmonitor 09:10:36 INFO - Running setup.py install for mozsystemmonitor 09:10:36 INFO - Successfully installed mozsystemmonitor 09:10:36 INFO - Cleaning up... 09:10:36 INFO - Return code: 0 09:10:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:10:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:36 INFO - 'HOME': '/Users/cltbld', 09:10:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:36 INFO - 'LOGNAME': 'cltbld', 09:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:36 INFO - 'MOZ_NO_REMOTE': '1', 09:10:36 INFO - 'NO_EM_RESTART': '1', 09:10:36 INFO - 'PAGER': '/bin/cat', 09:10:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:36 INFO - 'PWD': '/builds/slave/test', 09:10:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:36 INFO - 'SHELL': '/bin/bash', 09:10:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:36 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:36 INFO - 'USER': 'cltbld', 09:10:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:36 INFO - 'XPC_FLAGS': '0x0', 09:10:36 INFO - 'XPC_SERVICE_NAME': '0', 09:10:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:36 INFO - Downloading/unpacking jsonschema==2.5.1 09:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:10:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:10:39 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 09:10:39 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 09:10:39 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 09:10:39 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 09:10:39 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 09:10:39 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 09:10:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:10:39 INFO - warning: no files found matching '*.txt' 09:10:39 INFO - no previously-included directories found matching 'build' 09:10:39 INFO - no previously-included directories found matching 'dist' 09:10:39 INFO - no previously-included directories found matching '.git*' 09:10:39 INFO - Installing collected packages: jsonschema, functools32 09:10:39 INFO - Running setup.py install for functools32 09:10:40 INFO - warning: no files found matching '*.txt' 09:10:40 INFO - no previously-included directories found matching 'build' 09:10:40 INFO - no previously-included directories found matching 'dist' 09:10:40 INFO - no previously-included directories found matching '.git*' 09:10:40 INFO - Successfully installed jsonschema functools32 09:10:40 INFO - Cleaning up... 09:10:40 INFO - Return code: 0 09:10:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:40 INFO - 'HOME': '/Users/cltbld', 09:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:40 INFO - 'LOGNAME': 'cltbld', 09:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:40 INFO - 'MOZ_NO_REMOTE': '1', 09:10:40 INFO - 'NO_EM_RESTART': '1', 09:10:40 INFO - 'PAGER': '/bin/cat', 09:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:40 INFO - 'PWD': '/builds/slave/test', 09:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:40 INFO - 'SHELL': '/bin/bash', 09:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:40 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:40 INFO - 'USER': 'cltbld', 09:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:40 INFO - 'XPC_FLAGS': '0x0', 09:10:40 INFO - 'XPC_SERVICE_NAME': '0', 09:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:10:40 INFO - Cleaning up... 09:10:40 INFO - Return code: 0 09:10:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:40 INFO - 'HOME': '/Users/cltbld', 09:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:40 INFO - 'LOGNAME': 'cltbld', 09:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:40 INFO - 'MOZ_NO_REMOTE': '1', 09:10:40 INFO - 'NO_EM_RESTART': '1', 09:10:40 INFO - 'PAGER': '/bin/cat', 09:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:40 INFO - 'PWD': '/builds/slave/test', 09:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:40 INFO - 'SHELL': '/bin/bash', 09:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:40 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:40 INFO - 'USER': 'cltbld', 09:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:40 INFO - 'XPC_FLAGS': '0x0', 09:10:40 INFO - 'XPC_SERVICE_NAME': '0', 09:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10:43 INFO - Downloading blobuploader-1.2.4.tar.gz 09:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:10:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:10:43 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 09:10:43 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 09:10:43 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 09:10:43 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 09:10:43 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 09:10:43 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 09:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:10:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:44 INFO - Downloading docopt-0.6.1.tar.gz 09:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 09:10:44 INFO - Running setup.py install for blobuploader 09:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:10:44 INFO - Running setup.py install for requests 09:10:45 INFO - Running setup.py install for docopt 09:10:45 INFO - Successfully installed blobuploader requests docopt 09:10:45 INFO - Cleaning up... 09:10:45 INFO - Return code: 0 09:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:45 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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:45 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 09:10:45 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 09:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:45 INFO - 'HOME': '/Users/cltbld', 09:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:45 INFO - 'LOGNAME': 'cltbld', 09:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:45 INFO - 'MOZ_NO_REMOTE': '1', 09:10:45 INFO - 'NO_EM_RESTART': '1', 09:10:45 INFO - 'PAGER': '/bin/cat', 09:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:45 INFO - 'PWD': '/builds/slave/test', 09:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:45 INFO - 'SHELL': '/bin/bash', 09:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:45 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:45 INFO - 'USER': 'cltbld', 09:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:45 INFO - 'XPC_FLAGS': '0x0', 09:10:45 INFO - 'XPC_SERVICE_NAME': '0', 09:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-hCrA5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-DaXoRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-euWKj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-2Pzxu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-KKs13Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-iAHM1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Mw31Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3vNlx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-glcVaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-WgQ4IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-kT3ahI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-keIj1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-QZeoei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-yPJv7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3GIZCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-dnvunw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-2x9Q7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:10:47 INFO - Running setup.py install for manifestparser 09:10:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:10:47 INFO - Running setup.py install for mozcrash 09:10:47 INFO - Running setup.py install for mozdebug 09:10:48 INFO - Running setup.py install for mozdevice 09:10:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Running setup.py install for mozfile 09:10:48 INFO - Running setup.py install for mozhttpd 09:10:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Running setup.py install for mozinfo 09:10:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Running setup.py install for mozInstall 09:10:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:10:48 INFO - Running setup.py install for mozleak 09:10:49 INFO - Running setup.py install for mozlog 09:10:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:10:49 INFO - Running setup.py install for moznetwork 09:10:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:10:49 INFO - Running setup.py install for mozprocess 09:10:49 INFO - Running setup.py install for mozprofile 09:10:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:10:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:10:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:10:49 INFO - Running setup.py install for mozrunner 09:10:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:10:49 INFO - Running setup.py install for mozscreenshot 09:10:49 INFO - Running setup.py install for moztest 09:10:50 INFO - Running setup.py install for mozversion 09:10:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:10:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:10:50 INFO - Cleaning up... 09:10:50 INFO - Return code: 0 09:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:50 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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:50 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 09:10:50 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 09:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:50 INFO - 'HOME': '/Users/cltbld', 09:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:50 INFO - 'LOGNAME': 'cltbld', 09:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:50 INFO - 'MOZ_NO_REMOTE': '1', 09:10:50 INFO - 'NO_EM_RESTART': '1', 09:10:50 INFO - 'PAGER': '/bin/cat', 09:10:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:50 INFO - 'PWD': '/builds/slave/test', 09:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:50 INFO - 'SHELL': '/bin/bash', 09:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:50 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:50 INFO - 'USER': 'cltbld', 09:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:50 INFO - 'XPC_FLAGS': '0x0', 09:10:50 INFO - 'XPC_SERVICE_NAME': '0', 09:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-W3w0Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:50 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)) 09:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-SyNVM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:50 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)) 09:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-AKMuWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:50 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)) 09:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-wnQyMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-nXUxFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-hcGpC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-zVaSaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-SzPDml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_GrM8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-2zTrI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-MyTyGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-FwRqGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-HRzSTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:51 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)) 09:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-nY4Dsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:52 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)) 09:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-c96UaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:52 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)) 09:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Owz8Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-AIcRVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:52 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)) 09:10:52 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)) 09:10:52 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)) 09:10:52 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)) 09:10:52 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)) 09:10:52 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)) 09:10:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:55 INFO - Downloading blessings-1.6.tar.gz 09:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:10:55 INFO - Installing collected packages: blessings 09:10:55 INFO - Running setup.py install for blessings 09:10:55 INFO - Successfully installed blessings 09:10:55 INFO - Cleaning up... 09:10:55 INFO - Return code: 0 09:10:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:55 INFO - Reading from file tmpfile_stdout 09:10:55 INFO - Current package versions: 09:10:55 INFO - blessings == 1.6 09:10:55 INFO - blobuploader == 1.2.4 09:10:55 INFO - docopt == 0.6.1 09:10:55 INFO - functools32 == 3.2.3-2 09:10:55 INFO - jsonschema == 2.5.1 09:10:55 INFO - manifestparser == 1.1 09:10:55 INFO - mozInstall == 1.12 09:10:55 INFO - mozcrash == 1.0 09:10:55 INFO - mozdebug == 0.1 09:10:55 INFO - mozdevice == 0.49 09:10:55 INFO - mozfile == 1.2 09:10:55 INFO - mozhttpd == 0.7 09:10:55 INFO - mozinfo == 0.9 09:10:55 INFO - mozleak == 0.1 09:10:55 INFO - mozlog == 3.4 09:10:55 INFO - moznetwork == 0.27 09:10:55 INFO - mozprocess == 0.24 09:10:55 INFO - mozprofile == 0.28 09:10:55 INFO - mozrunner == 6.13 09:10:55 INFO - mozscreenshot == 0.1 09:10:55 INFO - mozsystemmonitor == 0.3 09:10:55 INFO - moztest == 0.8 09:10:55 INFO - mozversion == 1.4 09:10:55 INFO - psutil == 3.1.1 09:10:55 INFO - requests == 1.2.3 09:10:55 INFO - wsgiref == 0.1.2 09:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:56 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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:56 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 09:10:56 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 09:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:56 INFO - 'HOME': '/Users/cltbld', 09:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:56 INFO - 'LOGNAME': 'cltbld', 09:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:56 INFO - 'MOZ_NO_REMOTE': '1', 09:10:56 INFO - 'NO_EM_RESTART': '1', 09:10:56 INFO - 'PAGER': '/bin/cat', 09:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:56 INFO - 'PWD': '/builds/slave/test', 09:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:56 INFO - 'SHELL': '/bin/bash', 09:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:56 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:56 INFO - 'USER': 'cltbld', 09:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:56 INFO - 'XPC_FLAGS': '0x0', 09:10:56 INFO - 'XPC_SERVICE_NAME': '0', 09:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 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)) 09:10:56 INFO - Cleaning up... 09:10:56 INFO - Return code: 0 09:10:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:57 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 0x104b2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2b4b8e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, '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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 09:10:57 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 09:10:57 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 09:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:57 INFO - 'HOME': '/Users/cltbld', 09:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:57 INFO - 'LOGNAME': 'cltbld', 09:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:57 INFO - 'MOZ_NO_REMOTE': '1', 09:10:57 INFO - 'NO_EM_RESTART': '1', 09:10:57 INFO - 'PAGER': '/bin/cat', 09:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:57 INFO - 'PWD': '/builds/slave/test', 09:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:57 INFO - 'SHELL': '/bin/bash', 09:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:10:57 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:57 INFO - 'USER': 'cltbld', 09:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:57 INFO - 'XPC_FLAGS': '0x0', 09:10:57 INFO - 'XPC_SERVICE_NAME': '0', 09:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:10:57 INFO - Cleaning up... 09:10:57 INFO - Return code: 0 09:10:57 INFO - Running post-action listener: _resource_record_post_action 09:10:57 INFO - Running post-action listener: _start_resource_monitoring 09:10:57 INFO - Starting resource monitoring. 09:10:57 INFO - [mozharness: 2017-02-02 17:10:57.449592Z] Finished create-virtualenv step (success) 09:10:57 INFO - [mozharness: 2017-02-02 17:10:57.450634Z] Running install step. 09:10:57 INFO - Running pre-action listener: _resource_record_pre_action 09:10:57 INFO - Running main action method: install 09:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:57 INFO - Reading from file tmpfile_stdout 09:10:57 INFO - Detecting whether we're running mozinstall >=1.0... 09:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:10:57 INFO - Reading from file tmpfile_stdout 09:10:57 INFO - Output received: 09:10:57 INFO - Usage: mozinstall [options] installer 09:10:57 INFO - Options: 09:10:57 INFO - -h, --help show this help message and exit 09:10:57 INFO - -d DEST, --destination=DEST 09:10:57 INFO - Directory to install application into. [default: 09:10:57 INFO - "/builds/slave/test"] 09:10:57 INFO - --app=APP Application being installed. [default: firefox] 09:10:57 INFO - mkdir: /builds/slave/test/build/application 09:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:11:17 INFO - Reading from file tmpfile_stdout 09:11:17 INFO - Output received: 09:11:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:11:17 INFO - Running post-action listener: _resource_record_post_action 09:11:17 INFO - [mozharness: 2017-02-02 17:11:17.783341Z] Finished install step (success) 09:11:17 INFO - [mozharness: 2017-02-02 17:11:17.783513Z] Running run-tests step. 09:11:17 INFO - Running pre-action listener: _resource_record_pre_action 09:11:17 INFO - Running main action method: run_tests 09:11:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:17 INFO - 2017-02-02 09:11:17.798 screenresolution[1624:7441] starting screenresolution argv=screenresolution get 09:11:17 INFO - 2017-02-02 09:11:17.800 screenresolution[1624:7441] Display 0: 1600x1200x32@60 09:11:17 INFO - 2017-02-02 09:11:17.806 screenresolution[1625:7444] starting screenresolution argv=screenresolution list 09:11:17 INFO - Available Modes on Display 0 09:11:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:18 INFO - Intel Iris: 09:11:18 INFO - Chipset Model: Intel Iris 09:11:18 INFO - Type: GPU 09:11:18 INFO - Bus: Built-In 09:11:18 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:18 INFO - Vendor: Intel (0x8086) 09:11:18 INFO - Device ID: 0x0a2e 09:11:18 INFO - Revision ID: 0x0009 09:11:18 INFO - Displays: 09:11:18 INFO - Display: 09:11:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:18 INFO - Display Serial Number: 1600x1200 60 09:11:18 INFO - Main Display: Yes 09:11:18 INFO - Mirror: Off 09:11:18 INFO - Online: Yes 09:11:18 INFO - Rotation: Supported 09:11:18 INFO - Return code: 0 09:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:18 INFO - Python 2.7.3 09:11:18 INFO - Return code: 0 09:11:18 INFO - grabbing minidump binary from tooltool 09:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:18 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 0x104908d30>, '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 0x10482fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048fdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:18 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 09:11:18 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 09:11:18 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 09:11:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:18 INFO - Return code: 0 09:11:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:11:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:11:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 09:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --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 09:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8NPtBxXfJr/Render', 09:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:18 INFO - 'HOME': '/Users/cltbld', 09:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:18 INFO - 'LOGNAME': 'cltbld', 09:11:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:18 INFO - 'MOZ_NO_REMOTE': '1', 09:11:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:18 INFO - 'NO_EM_RESTART': '1', 09:11:18 INFO - 'PAGER': '/bin/cat', 09:11:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:18 INFO - 'PWD': '/builds/slave/test', 09:11:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:18 INFO - 'SHELL': '/bin/bash', 09:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DI6qmp4eLa/Listeners', 09:11:18 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 09:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:18 INFO - 'USER': 'cltbld', 09:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:18 INFO - 'XPC_FLAGS': '0x0', 09:11:18 INFO - 'XPC_SERVICE_NAME': '0', 09:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 09:11:18 INFO - mozversion application_buildid: 20170202073219 09:11:18 INFO - mozversion application_changeset: cd8688f42f8a32f24906ef5de60000e2759546ea 09:11:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:11:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:18 INFO - mozversion application_name: Firefox 09:11:18 INFO - mozversion application_remotingname: firefox-dev 09:11:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:18 INFO - mozversion application_vendor: Mozilla 09:11:18 INFO - mozversion application_version: 53.0a2 09:11:18 INFO - mozversion platform_buildid: 20170202073219 09:11:18 INFO - mozversion platform_changeset: cd8688f42f8a32f24906ef5de60000e2759546ea 09:11:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:18 INFO - mozversion platform_version: 53.0a2 09:11:18 INFO - using testdate: 1486055478 09:11:18 INFO - actual date: 1486055478 09:11:18 INFO - starting webserver on 'localhost:49241' 09:11:18 INFO - SUITE-START | Running 2 tests 09:11:18 INFO - TEST-START | dromaeo_css 09:11:18 INFO - operating with platform_type : mac_ 09:11:18 INFO - Initialising browser for dromaeo_css test... 09:11:18 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpQjqxu6/profile http://localhost:49241/getInfo.html) 09:11:20 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:11:20 INFO - PROCESS | 1635 | colorDepth:24 09:11:20 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:11:20 INFO - PROCESS | 1635 | __metrics 09:11:20 INFO - PROCESS | 1635 | 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" 09:11:20 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:21 INFO - TEST-INFO | 1635: exit 0 09:11:21 INFO - Browser initialized. 09:11:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:11:21 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpQjqxu6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:33 INFO - PROCESS | 1637 | RSS: Main: 213209088 09:11:33 INFO - PROCESS | 1637 | 09:14:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:14:39 INFO - PROCESS | 1637 | RSS: Main: 344387584 09:14:39 INFO - PROCESS | 1637 | 09:16:23 INFO - PROCESS | 1637 | ************************* 09:16:23 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 09:16:23 INFO - PROCESS | 1637 | 09:16:23 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:16:23 INFO - PROCESS | 1637 | Full stack: 09:16:23 INFO - PROCESS | 1637 | ************************* 09:17:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:17:42 INFO - PROCESS | 1637 | RSS: Main: 351805440 09:17:42 INFO - PROCESS | 1637 | 09:20:45 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:20:45 INFO - PROCESS | 1637 | RSS: Main: 313995264 09:20:45 INFO - PROCESS | 1637 | 09:23:48 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:23:48 INFO - PROCESS | 1637 | RSS: Main: 314540032 09:23:48 INFO - PROCESS | 1637 | 09:26:52 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:26:53 INFO - PROCESS | 1637 | RSS: Main: 311238656 09:26:53 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:29:56 INFO - PROCESS | 1637 | RSS: Main: 420093952 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | __start_tp_report 09:29:56 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 09:29:56 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 09:29:56 INFO - PROCESS | 1637 | |i|pagename|runs| 09:29:56 INFO - PROCESS | 1637 | |0;dojo.html;3305.9338813223735;3323.185819474229;3325.7006869381757;3364.899053028407;3385.5429517015195;4701.905961880769;5690.943090569093;5709.971450142754;5749.597528173019;5773.5092517136045;5697.715114244292;5750.338711048231;5768.653880767147;5772.769089236436;5780.219670344512;4351.26028575143;5219.686818790875;5227.555657769094;5243.554297884665;5249.5012973767625;5153.896922061575;5186.247994040862;5194.27280180775;5254.133068043769;5327.413984461706;5290.6825590464505;5294.947050529503;5298.655587386807;5301.204819277101;5303.761330740126;5254.553362964152;5254.894902101936;5257.395399529046;5259.921101183485;5264.052470555299;5098.388193416777;5200.531952124327;5204.479552044803;5205.583553315726;5264.789408423659;5772.624779389326;5779.3642699303045;5781.248437703114;5785.2189954356045;5812.534997200214;6139.001538246403;6145.877082458326;6168.0439531872635;6184.288806787187;6190.96904515479;6281.3404592518045;6296.087067375205;6301.212348456443;6309.5898766580485;6312.305646378894;5775.826725198251;5795.072788353843;5795.072788353886;5868.618539794899;5880.617759845682;5211.8175863845345;6191.597546159485;6256.249250090018;6270.2475702915945;6275.497960163268;6105.308121371101;6220.03589443637;6225.657588832658;6230.252369715572;6238.812835614939;6210.596311239755;6256.468200203034;6273.592216505913;6277.780277690259;6294.496440284766;6133.907991380132;6234.657093859882;6250.624962502265;6252.218472690914;6275.96862015687;6142.590862071594;6145.016797312409;6153.861535615925;6203.937960620336;6209.161763162006;4973.42805577356;4977.726225057584;4981.501849814989;4983.700977941335;5011.574016208663;4420.624246938982;4420.624246938982;4423.977880110579;4427.977860110744;4466.665000125004;5629.493345598916;5697.772089116389;5707.8858422832145;5735.684537350486;5800.477956983892;6213.906791398133;6223.066540019034;6239.0953311770445;6256.655883926428;6265.686715664198;5809.651420914759;5813.832087938302;5818.621789583748;5822.621529600562;5878.559108066826;5334.413214546396;5336.519713225828;5467.343918729778;5484.314460692413;5503.834884953458;6211.503079753699;6214.161088253209;6233.96883015582;6254.4996400286955;6304.7162877671535;5109.591232701449;6157.983932651063;6197.566170368031;6203.534734894991;6299.559030867796;6161.84595385119;6265.404786545271;6306.180196574416;6307.90538141919;6309.747610095728;6232.719527621359;6235.594686345373;6263.592866463665;6263.655498947602;6281.152044473937;6070.2412198475195;6110.5587591967305;6133.548895741652;6154.9384506154365;6318.241810982528;6135.722664536972;6156.5998210116195;6167.814965551041;6169.56813023084;6172.22847144107;6135.294441139326;6136.877262454636;6142.938570614237;6144.863200307957;6146.78486252979;5774.162746401832;5777;5846.795362162304;5921.259842519685;5948.851278718067;6017.2779266488305;6096.847578810565;6098.512119030555;6112.572119951738;6119;5902.085176797603;5924.170616113662;5932.733027013708;5934.376890426615;5945.078512830518 09:29:56 INFO - PROCESS | 1637 | |1;ext.html;461.395571800941;495.764511856868;498.3396998976355;509.6407033041706;509.9031184075027;30770.53844192336;40443.79778101109;41918;42106.7894660527;42124.157516849686;35088.82455587725;42170.36744448836;42400.57599424005;42546.57453425472;42758;9126.54367281635;9307.674231401903;9335.159835614793;9341.906580934206;9359.157675809176;8281.668733250663;8547.487150770943;8555.871661925075;8631.654733810672;8645.827083458327;11000.449977501134;11276.887231127706;11289.830652540219;11414.885851141507;11449.656510304705;11114.388708621023;11182.832257516144;11202.775944481145;11219.326840389604;11247.493862776113;8278.296344810698;8497.277731392838;11096.1123110151;11182.105431565455;11199.776004479865;39997.60002399968;40578;40922.590774092474;42554;42707.14585708269;3887.3455026165816;4004.5594984551676;4004.65960393364;4035;4136.5417792714015;28920.855395723098;28981.85509072462;28995.565066524017;29241.41517169666;30146.397072058655;3111.2688518198206;3315.187778994162;3380.645032271625;3384.881529146468;3386.5766779152605;470851;471670;475746;476649;476859;62460;62685;62926;62966.37033629697;63028.36971630225;65586.67206664031;65706.0144097839;65711;65898.34101658923;65933;16746;16881.32474701023;16945.49163525096;16962.660746784994;17007.659846802995;12955;13086.14940028895;13185.208887466782;13224.735505290033;13225.735485290434;13702.45190192381;14400.495982640767;14789.594988476078;16495.670086598202;21310.573788524143;8648.308135349156;8814.735557933143;8827.823443531093;8837.867431988525;8877.511736854405;755.8563872864138;880.6169316347409;905.8902844016028;908.9863652045225;912.8904531456268;26172.8691356542;29402.558961615592;29558.96543620963;30371.92549550286;30851.382972340427;1044.9477526123662;1076.9138468922467;1078.1967434261526;1103.200179869588;1117.6200091968608;15549.611259718371;15587.908846380871;15632.531024069296;15841.970271932287;15902.68194636124;587640;592014;592454;593503;593666;62063.6896815513;62392.37607623866;62674;62678.686606567586;62805;1287.5493577248076;1433.3549902543898;1444.9638759031109;1478.8003619511658;1483.473366954737;24790;29157.70842291635;30109.849450752605;30177.396452070396;30177.698223017487;41271.58728412678;51545.48454515407;51811.74094129505;51889;51942.48057519377;578388;578591;588619;589858.0507097609;590790;42790.93022674458;42974.355384668626;43743.56256437395;43778.343324850786;43819.34270985874;46754;47062.76468617635;47136.52863471321;47483.050338993715;47847.76076119597;33578.49632255567;38766.80616596899;39196.21607567776;39201.80399097986;39546.83625310026;38568.6143138565;38690.6130938687;38691.613083868804;38758.837234883;38903;36581.63418365782;37321.44017839789;38151;38160.61839381682;38363;30766.38467230598;33941.03531707651;34211.657883421845;34395.65604344025;34492.82753586216;20974.580508390052;24461.51076978486;24875;24962.750372496044;25157 09:29:56 INFO - PROCESS | 1637 | |2;jquery.html;332.41826803094585;372.6385406156028;390.5762247960962;400.4493820996131;424.67300178862274;14764.704705905875;15484.922575387121;18453.815461845377;20964.58070838586;20995.95020248989;21584.460388490297;21712.3486295411;22076.448088797788;22213.44466388337;22356.10575576979;5457.208704737811;5791.768329266845;5966.164736936832;6039.5772295939305;6110.236220472441;4221.24017676818;5881.470667639912;5985.730642121115;5989.490893274055;5998.5800993930225;4407.603315701586;6231.563790534665;6479.773207937723;6508.967455162741;6602.075709400688;6336.112944187817;6566.868662626721;6578.901316480256;6617.073609694647;6644.568103073285;5742.339630942453;5816.098504731774;5826.504747096502;5827.766889324422;5833.912491312633;20973.68539471909;21223.151073957022;26287.868560657265;26306.21081367562;26607.866960665266;2806.761425278854;2829.349249672566;2833.9008134715186;2841.815282006663;2872.6696429910617;13109.47562097515;15417.306221220071;15468.30392632323;15848.841511584968;15963.910973755632;1568.6705791783738;1799.9190036448392;1805.0201191769827;1812.7401455988092;1829.8746271043212;96334;122962;125411;128431;153563.23218383838;18555.628887422445;18891.62216755685;23596;23624.291271261547;24140.70663286985;41155;41172.38241426381;41821.95445113836;42067.78966105211;42398.940026499586;8648.221660050625;8974.820503589892;9161.816763664823;9170.358074934824;9246.121618446237;7367.8894816577795;8793.912060879436;8885.289176865836;8901.109889011048;9130.497822619687;4783.497732738082;4841.353939660532;4859.80560777572;4893.828715994923;4972.353594032825;1770.9911450442664;1840.9723854142198;1943.5335519475225;2011.3764732932837;2057.567910738732;960.1790469148917;996.5067291690659;1024.938503689766;1031.417249254169;1057.5875408590503;21668.34994950154;22161.445963851034;22177.334679959626;22285.220017299318;22293.108275669118;1051.4059556350637;1051.8632577764843;1054.1619412567027;1056.7252514346326;1059.7615536504225;10749.516271767789;11451.568553930758;11475.71310717222;11489;11740.58907938218;654625;664678;712240;741448;773146;90747.58413532816;145701;149511;155377;164759;1028.377831412;1041.3127335958231;1062.049465728169;1063.197286049028;1063.7500187456096;19592.804071959097;20140.295089671792;21515.354539363845;21612.45968850791;21667;47897;57989.710051449474;58681;61066.69466652638;61665;80346;86987.56506217428;87908.12091879256;89870.65194022226;91501;8138.3082437993435;8222.506649601042;8236.34109271245;8472.322214222724;8504.617292221988;7620.733274335372;11797.820217978133;12860.549880754128;13289.003324750489;13833.377498012815;11291.491882865126;11377.20359574855;11690.590829320932;11971.221870578385;11983.28100313984;9796.265280103878;11273.943630281796;11491.8276225855;11501.597444089417;11756.764864702487;11332.093432525213;11567.479463423997;11714.76570468603;11751.236169648946;11764.35296058725;7781.06627204739;8258.958705206436;8436.409451338348;8491.23578877904;8728.607212675317;6176.66028368444;8167.224113709188;11267.887321126684;11625.011873990466;11994.820077698667 09:29:56 INFO - PROCESS | 1637 | |3;mootools.html;1262.7853264944958;1375.6973465837516;1418.9787153192703;1438.5684294711584;1451.9056261343005;8047.678092876278;8447.91552084479;8466.619002144902;8470.237678608924;8477;7370.336669699726;7661.770146895588;7673.079230492335;7736.845263094735;7765.805854853632;2085.8748475091465;2131.6589345704692;2226.309843948373;2348.3307257431634;2349.2012715676665;2328.9534209315802;2378.2151889876386;2385.916492922748;2389.7729715676983;2394.4851856850773;2255.3234029790997;2316.200910685819;2316.3514216019544;2317.1194945920524;2317.9884100579475;2043.7036629688687;2132.083204222176;2256.8307376946796;2333.3583264602203;2339.508703172336;2306.308107567723;2323.6630688550067;2324.476992676651;2330.149495434171;2340.9297721068397;8259.38054645904;8349.666013359458;8354.624041918129;8358.122397148272;8363.749087527323;5004.573696496517;5180.481951804827;5183.974080129613;5185.299984502081;5233.2935053768015;3181.427343078245;3392.0332705178907;3507.4914137449928;3539.2744487380023;3539.4513850353237;1150.3098141115347;1156.1733360647092;1224.9877501224962;1237.5730373021293;1238.4179435665224;10674.786504269949;10744.14046876248;10799.67600971972;10812;10813.026827585476;3862.633049860259;4668.323093151542;4735.739534325645;4742.857714268577;4745.050989802054;9455.763605909908;9475.573599188054;9476.241900647932;9477.857832132524;9481.194098501566;5188.143956247177;5257.290265814143;5260.263563101169;5264.842054738364;5273.288106105703;4585.839495617637;4695.154872122982;4698.600618947359;4756.667033307635;4780.737059461693;3604.891853244407;3714.4799728038097;3714.888553343404;3870.5161854768153;3979.5821438749094;1226.0804396702474;1262.741138066694;1269.9873001270055;1271.6185144456626;1283.0569531394417;786.8087376655985;854.3464249848746;889.0975659705405;895.3329769321897;906.8911730592371;5332.173513105475;5386.434424385383;5408;5626.915596266059;5669.971650141723;985.640241311916;994.3437331361267;996.1731762636994;1022.4529876516028;1037.725002874239;3560.5193298904833;3692.409214525717;3702.4631428442726;3711.406175011985;3835.328817456934;9597.712068637813;9950.80098398028;9966.352187107816;9974.202063834875;10018.849717254247;9401.153896149242;9841.803163936682;9842.261830362751;9847.507624618884;9847.950760246153;7667.8849817252785;7728.613569321511;7733.110692270348;7877.291043806085;7882.172371900982;4554.578736333603;5448.809291674931;5458.972705136449;5696.743646535833;5804.506616937439;8541.786455338666;8803.867941980747;8889.288856891304;8997.55012249398;9094.045125262017;9071.047540008469;9173.77065573366;9199.494027828534;9267.953660231655;9389.483578403253;6566.606003639797;6648.700808463727;6648.767293144717;6656.633885136364;6671.33286671329;6941.757038503628;7043.119610048744;7054.788356349318;7101.39638130744;7166.211716711262;6457.354264573505;6497.512686548623;6517.4134327910715;6560.048792925095;6591.373819487141;6396.808095757135;6436.613803171825;6451.70967306463;6476.481881449567;6484.416402523795;5799.188113664006;5905.40945905406;5907;5909.172715819875;5918.674472904032;4591.127685739699;4607.539246075366;4647.419072615923;4648.535146485325;4668.463126740468;4543.909121817611;4561.338605902192;4641.6286697064825;4772.761361931959;4812.374391329105 09:29:56 INFO - PROCESS | 1637 | |4;prototype.html;348.8290737538606;357.9821008949552;359.52004074560466;370.6460330384483;371.120444546425;4453.821847126115;5100.908627462741;5157.355330583672;5164.922526162101;5204.245384419257;3783.5081439412907;4190.182914331706;4929.383827021622;4977.05894701066;4986.279733491949;3367.478040903664;3963.881083567483;4019.2564375590464;4083.367078102884;4083.8570650027254;4005.4192142139373;4038.5557588665224;4054.97972510137;4060.4112403701447;4105.9615884245595;3175.666555011725;3692.8892133236045;3763.604821493731;3853.4797802296753;3900.9219815603815;3139.022415878005;3559.394902866493;3991.7804520751347;4020.4974378202724;4029.9573821764675;2954.9509923976893;3352.513885486591;3584.888684507811;3599.766015209003;3615.439606860941;4136.896577585554;4152.4601801765575;4971.204607262821;4997.225430058346;5011.298418221452;4089.9182016359505;4378.8029538670835;4609.3777340059;4645.303204519315;4651.418572678415;5005.449400565934;5080.314157588752;5458.226076525106;5490.646619545951;5502.697351645658;4016.096378314885;4021.296273152216;4023.8591649292134;4026.7583944963394;4031.5363733170766;5601.579881508903;5666.518345940642;5669.744861481243;5672.716364181774;5757.136429535603;3590.9461358079648;4050.3721923101966;4052.8986775330263;4090.1819636072905;4095.877123686294;3655.9634403655623;3803.752756070902;3822.50307460034;3968.6428221460205;4141.109661422808;4168.458100446923;4237.618614324664;4641.721496710208;4675.836345727883;4715.24556071027;4621.69958952667;4628.884277893079;5496.268675367247;5497.065498865202;5546.278983732089;1334.3061607963805;1344.5294147048455;1353.7630914589906;1354.4243696428978;1357.7895426208954;855.6192494340083;887.8446271902392;904.5115637555647;933.776752454287;952.5618215620754;3993.7204395692024;4084.509858816961;4529.750863702528;4654.557817007447;4770.141374552544;4477.70894891831;4865.270209468537;5169.9741501293;5221.738913054408;5254.0805359062015;4086.833977991669;4668.439787225487;4694.502595566325;4725.480197178307;4741.57325840676;2494.837835540684;2498.900483787128;2533.70862350832;2702.932426689309;2796.678381986057;4708;5304.814331498456;5410.701431656375;5478.91781623276;5526.861828454321;4591.770411479412;4900.373723444625;5017.874553136201;5440.755166017539;5648.717564121777;4859.659823812299;5257.2902658140665;5316.627836051439;5750.827475175752;5754.367019627922;4713.387259656222;4828.961773218774;5534.280543529477;5567.220589117608;5574.498295153456;4636.976815115903;4706.458757242824;4894.779734912009;5279.340082489689;5472.91790623149;5059.519345662156;5343.11838546651;5700.059490184073;5710.2862142232225;5721.656700597978;3625.803484850046;3640.7451478396256;3644.6902013328104;3661.2860492203763;3671.8347674355255;4682.274247491644;4789.592884604708;5155.845324640267;5561.63849349791;5690.451809485884;4712.59942904857;5206.193040078794;5400.783968641211;5425.267588875609;5443.455654434525;4290.356446533045;5304.708241046779;5306.363236411501;5351.153851921081;5403.351597808131;5032;5134.794608215779;5166.638335316642;5184.533391994739;5228.738563071907;4419.80110895017;4872.585830204473;5290.44450332725;5292.603054770831;5323.600729945192;5000.924986125284;5265.578753699771;5291.841244762663;5304.655197412156;5363.5440987516495 09:29:56 INFO - PROCESS | 1637 | |5;yui.html;693.5828637199362;733.493889216441;769.5267410542515;817.5503473089801;829.0672992883007;14869.256537173153;15811.525654230363;15831.683366332667;15864.444744433933;15895.841041589581;14257.643558911032;14392.71214575708;14404.423823047066;14416.062955907859;14430.278486075707;685.0477835808231;708.4438715608248;709.6735501669212;848.295914391054;863.0592654007115;790.3992965346349;824.742268041239;872.899616544096;884.6594061286419;889.884315039044;924.1497822003772;937.6671281695002;941.3598752848061;941.38809773647;942.3403617467766;717.4224749076991;912.6942474271127;930.1767935377172;937.0020927711965;938.699616122841;550.3780727777626;670.9630970296631;687.2440315652742;696.7631005458118;699.464909344352;15070.623234419118;15140.545783626509;15162.772558411632;15165.469208577757;15167;11832.88167118335;11845.348505832177;11954.880451195464;11977.341246231454;12179.269243845309;12212.633620991384;12299.754004919852;12463.501459941592;12472.563460278938;12559.246445213317;4185.372194170868;4477.619402350804;4481.932771008405;4590.081983603292;4630.467496237942;97849;106774.46612766964;106884.46557767161;107143;107593;10461.70456306261;10950.890491095146;11133.888661113448;11135;11324;21750.673739893915;21937.451563711034;21972.340829775134;21984.120635174735;22029.779702203094;6909.239983601799;7065.399441047466;7095.9645201773665;7126.093874303857;7169.96415017932;4214.354370423226;4270.530241673413;4289.722313099158;4324.070324880103;4369.825206991684;3433.261848702541;3491.4064609016527;3506.2461570762407;3550.094725844893;3556.893293201208;651.8402991267075;656.4649810404505;657.385344702695;660.5310229736845;714.0610097721479;644.2494493914537;648.2868844271264;648.4229036157823;651.9706613202417;681.8011911585197;8662.263707584925;9735.805283894424;9818.067283608189;10092.899071009197;10173.389596624227;652.9053287273414;667.549404152205;674.130371820356;675.5001299038775;679.6363945289246;4716.316134160596;4870.6103511718975;4871.074495845778;4896.36347274852;4919.434265059564;87695.1230487687;90438.09561904428;100009;101044.49477752564;102511;84669.72995405074;90335.09664903267;90706.54646726724;92422.53788731013;93399.53300233456;53147;62367.68816156072;63002.369976300564;67447;67846.98229526561;8851.203391694778;10338.689839304832;10653.598994080954;10781.679206975012;10870.130389568658;36896.89309320725;37652.43521347237;43975.78012109919;46405.83985400392;47645.28532071952;64143.358566413735;65755.34244657493;66571.66714166592;67357;67486.66256668685;12430;12753.171043882117;12766.489340426278;13034.934825325812;13198;11963.342016189194;12124.393780311126;12670.542887568048;13995.51015714445;14287.42850285977;11421.714457138638;11549.36478493691;12008.159428839897;12184.025277977918;12479.251244925334;12734;13575.456981720621;13717.862821371658;13903.652408689459;13941.233232172328;12755.043371746971;13581.86418135806;13747.813912237942;13878;13911;9926.602935882484;10422.166226701996;10862.34825910448;10940;11436.485358158736;8727.476351418934;9359.613268745343;10259.384436933808;11150.665480035612;11210.31845223223 09:29:56 INFO - PROCESS | 1637 | __end_tp_report 09:29:56 INFO - PROCESS | 1637 | __start_cc_report 09:29:56 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1156 09:29:56 INFO - PROCESS | 1637 | __end_cc_report 09:29:56 INFO - PROCESS | 1637 | __startTimestamp1486056596873__endTimestamp 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | ------- Summary: start ------- 09:29:56 INFO - PROCESS | 1637 | Number of tests: 6 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5737.98 Median:5924.17 stddev:645.40 (10.9%) stddev-sans-first:618.54 09:29:56 INFO - PROCESS | 1637 | Values: 3305.9 3323.2 3325.7 3364.9 3385.5 4701.9 5690.9 5710.0 5749.6 5773.5 5697.7 5750.3 5768.7 5772.8 5780.2 4351.3 5219.7 5227.6 5243.6 5249.5 5153.9 5186.2 5194.3 5254.1 5327.4 5290.7 5294.9 5298.7 5301.2 5303.8 5254.6 5254.9 5257.4 5259.9 5264.1 5098.4 5200.5 5204.5 5205.6 5264.8 5772.6 5779.4 5781.2 5785.2 5812.5 6139.0 6145.9 6168.0 6184.3 6191.0 6281.3 6296.1 6301.2 6309.6 6312.3 5775.8 5795.1 5795.1 5868.6 5880.6 5211.8 6191.6 6256.2 6270.2 6275.5 6105.3 6220.0 6225.7 6230.3 6238.8 6210.6 6256.5 6273.6 6277.8 6294.5 6133.9 6234.7 6250.6 6252.2 6276.0 6142.6 6145.0 6153.9 6203.9 6209.2 4973.4 4977.7 4981.5 4983.7 5011.6 4420.6 4420.6 4424.0 4428.0 4466.7 5629.5 5697.8 5707.9 5735.7 5800.5 6213.9 6223.1 6239.1 6256.7 6265.7 5809.7 5813.8 5818.6 5822.6 5878.6 5334.4 5336.5 5467.3 5484.3 5503.8 6211.5 6214.2 6234.0 6254.5 6304.7 5109.6 6158.0 6197.6 6203.5 6299.6 6161.8 6265.4 6306.2 6307.9 6309.7 6232.7 6235.6 6263.6 6263.7 6281.2 6070.2 6110.6 6133.5 6154.9 6318.2 6135.7 6156.6 6167.8 6169.6 6172.2 6135.3 6136.9 6142.9 6144.9 6146.8 5774.2 5777.0 5846.8 5921.3 5948.9 6017.3 6096.8 6098.5 6112.6 6119.0 5902.1 5924.2 5932.7 5934.4 5945.1 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:69348.81 Median:39772.22 stddev:147486.64 (370.8%) stddev-sans-first:147809.69 09:29:56 INFO - PROCESS | 1637 | Values: 461.4 495.8 498.3 509.6 509.9 30770.5 40443.8 41918.0 42106.8 42124.2 35088.8 42170.4 42400.6 42546.6 42758.0 9126.5 9307.7 9335.2 9341.9 9359.2 8281.7 8547.5 8555.9 8631.7 8645.8 11000.4 11276.9 11289.8 11414.9 11449.7 11114.4 11182.8 11202.8 11219.3 11247.5 8278.3 8497.3 11096.1 11182.1 11199.8 39997.6 40578.0 40922.6 42554.0 42707.1 3887.3 4004.6 4004.7 4035.0 4136.5 28920.9 28981.9 28995.6 29241.4 30146.4 3111.3 3315.2 3380.6 3384.9 3386.6 470851.0 471670.0 475746.0 476649.0 476859.0 62460.0 62685.0 62926.0 62966.4 63028.4 65586.7 65706.0 65711.0 65898.3 65933.0 16746.0 16881.3 16945.5 16962.7 17007.7 12955.0 13086.1 13185.2 13224.7 13225.7 13702.5 14400.5 14789.6 16495.7 21310.6 8648.3 8814.7 8827.8 8837.9 8877.5 755.9 880.6 905.9 909.0 912.9 26172.9 29402.6 29559.0 30371.9 30851.4 1044.9 1076.9 1078.2 1103.2 1117.6 15549.6 15587.9 15632.5 15842.0 15902.7 587640.0 592014.0 592454.0 593503.0 593666.0 62063.7 62392.4 62674.0 62678.7 62805.0 1287.5 1433.4 1445.0 1478.8 1483.5 24790.0 29157.7 30109.8 30177.4 30177.7 41271.6 51545.5 51811.7 51889.0 51942.5 578388.0 578591.0 588619.0 589858.1 590790.0 42790.9 42974.4 43743.6 43778.3 43819.3 46754.0 47062.8 47136.5 47483.1 47847.8 33578.5 38766.8 39196.2 39201.8 39546.8 38568.6 38690.6 38691.6 38758.8 38903.0 36581.6 37321.4 38151.0 38160.6 38363.0 30766.4 33941.0 34211.7 34395.7 34492.8 20974.6 24461.5 24875.0 24962.8 25157.0 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:40369.52 Median:26457.04 stddev:118187.98 (446.7%) stddev-sans-first:118481.29 09:29:56 INFO - PROCESS | 1637 | Values: 332.4 372.6 390.6 400.4 424.7 14764.7 15484.9 18453.8 20964.6 20996.0 21584.5 21712.3 22076.4 22213.4 22356.1 5457.2 5791.8 5966.2 6039.6 6110.2 4221.2 5881.5 5985.7 5989.5 5998.6 4407.6 6231.6 6479.8 6509.0 6602.1 6336.1 6566.9 6578.9 6617.1 6644.6 5742.3 5816.1 5826.5 5827.8 5833.9 20973.7 21223.2 26287.9 26306.2 26607.9 2806.8 2829.3 2833.9 2841.8 2872.7 13109.5 15417.3 15468.3 15848.8 15963.9 1568.7 1799.9 1805.0 1812.7 1829.9 96334.0 122962.0 125411.0 128431.0 153563.2 18555.6 18891.6 23596.0 23624.3 24140.7 41155.0 41172.4 41822.0 42067.8 42398.9 8648.2 8974.8 9161.8 9170.4 9246.1 7367.9 8793.9 8885.3 8901.1 9130.5 4783.5 4841.4 4859.8 4893.8 4972.4 1771.0 1841.0 1943.5 2011.4 2057.6 960.2 996.5 1024.9 1031.4 1057.6 21668.3 22161.4 22177.3 22285.2 22293.1 1051.4 1051.9 1054.2 1056.7 1059.8 10749.5 11451.6 11475.7 11489.0 11740.6 654625.0 664678.0 712240.0 741448.0 773146.0 90747.6 145701.0 149511.0 155377.0 164759.0 1028.4 1041.3 1062.0 1063.2 1063.8 19592.8 20140.3 21515.4 21612.5 21667.0 47897.0 57989.7 58681.0 61066.7 61665.0 80346.0 86987.6 87908.1 89870.7 91501.0 8138.3 8222.5 8236.3 8472.3 8504.6 7620.7 11797.8 12860.5 13289.0 13833.4 11291.5 11377.2 11690.6 11971.2 11983.3 9796.3 11273.9 11491.8 11501.6 11756.8 11332.1 11567.5 11714.8 11751.2 11764.4 7781.1 8259.0 8436.4 8491.2 8728.6 6176.7 8167.2 11267.9 11625.0 11994.8 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5294.83 Median:5258.78 stddev:2882.28 (54.8%) stddev-sans-first:2874.43 09:29:56 INFO - PROCESS | 1637 | Values: 1262.8 1375.7 1419.0 1438.6 1451.9 8047.7 8447.9 8466.6 8470.2 8477.0 7370.3 7661.8 7673.1 7736.8 7765.8 2085.9 2131.7 2226.3 2348.3 2349.2 2329.0 2378.2 2385.9 2389.8 2394.5 2255.3 2316.2 2316.4 2317.1 2318.0 2043.7 2132.1 2256.8 2333.4 2339.5 2306.3 2323.7 2324.5 2330.1 2340.9 8259.4 8349.7 8354.6 8358.1 8363.7 5004.6 5180.5 5184.0 5185.3 5233.3 3181.4 3392.0 3507.5 3539.3 3539.5 1150.3 1156.2 1225.0 1237.6 1238.4 10674.8 10744.1 10799.7 10812.0 10813.0 3862.6 4668.3 4735.7 4742.9 4745.1 9455.8 9475.6 9476.2 9477.9 9481.2 5188.1 5257.3 5260.3 5264.8 5273.3 4585.8 4695.2 4698.6 4756.7 4780.7 3604.9 3714.5 3714.9 3870.5 3979.6 1226.1 1262.7 1270.0 1271.6 1283.1 786.8 854.3 889.1 895.3 906.9 5332.2 5386.4 5408.0 5626.9 5670.0 985.6 994.3 996.2 1022.5 1037.7 3560.5 3692.4 3702.5 3711.4 3835.3 9597.7 9950.8 9966.4 9974.2 10018.8 9401.2 9841.8 9842.3 9847.5 9848.0 7667.9 7728.6 7733.1 7877.3 7882.2 4554.6 5448.8 5459.0 5696.7 5804.5 8541.8 8803.9 8889.3 8997.6 9094.0 9071.0 9173.8 9199.5 9268.0 9389.5 6566.6 6648.7 6648.8 6656.6 6671.3 6941.8 7043.1 7054.8 7101.4 7166.2 6457.4 6497.5 6517.4 6560.0 6591.4 6396.8 6436.6 6451.7 6476.5 6484.4 5799.2 5905.4 5907.0 5909.2 5918.7 4591.1 4607.5 4647.4 4648.5 4668.5 4543.9 4561.3 4641.6 4772.8 4812.4 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4316.89 Median:4710.30 stddev:1283.19 (27.2%) stddev-sans-first:1251.75 09:29:56 INFO - PROCESS | 1637 | Values: 348.8 358.0 359.5 370.6 371.1 4453.8 5100.9 5157.4 5164.9 5204.2 3783.5 4190.2 4929.4 4977.1 4986.3 3367.5 3963.9 4019.3 4083.4 4083.9 4005.4 4038.6 4055.0 4060.4 4106.0 3175.7 3692.9 3763.6 3853.5 3900.9 3139.0 3559.4 3991.8 4020.5 4030.0 2955.0 3352.5 3584.9 3599.8 3615.4 4136.9 4152.5 4971.2 4997.2 5011.3 4089.9 4378.8 4609.4 4645.3 4651.4 5005.4 5080.3 5458.2 5490.6 5502.7 4016.1 4021.3 4023.9 4026.8 4031.5 5601.6 5666.5 5669.7 5672.7 5757.1 3590.9 4050.4 4052.9 4090.2 4095.9 3656.0 3803.8 3822.5 3968.6 4141.1 4168.5 4237.6 4641.7 4675.8 4715.2 4621.7 4628.9 5496.3 5497.1 5546.3 1334.3 1344.5 1353.8 1354.4 1357.8 855.6 887.8 904.5 933.8 952.6 3993.7 4084.5 4529.8 4654.6 4770.1 4477.7 4865.3 5170.0 5221.7 5254.1 4086.8 4668.4 4694.5 4725.5 4741.6 2494.8 2498.9 2533.7 2702.9 2796.7 4708.0 5304.8 5410.7 5478.9 5526.9 4591.8 4900.4 5017.9 5440.8 5648.7 4859.7 5257.3 5316.6 5750.8 5754.4 4713.4 4829.0 5534.3 5567.2 5574.5 4637.0 4706.5 4894.8 5279.3 5472.9 5059.5 5343.1 5700.1 5710.3 5721.7 3625.8 3640.7 3644.7 3661.3 3671.8 4682.3 4789.6 5155.8 5561.6 5690.5 4712.6 5206.2 5400.8 5425.3 5443.5 4290.4 5304.7 5306.4 5351.2 5403.4 5032.0 5134.8 5166.6 5184.5 5228.7 4419.8 4872.6 5290.4 5292.6 5323.6 5000.9 5265.6 5291.8 5304.7 5363.5 09:29:56 INFO - PROCESS | 1637 | 09:29:56 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19520.80 Median:4306.90 stddev:27975.64 (649.6%) stddev-sans-first:28018.40 09:29:56 INFO - PROCESS | 1637 | Values: 693.6 733.5 769.5 817.6 829.1 14869.3 15811.5 15831.7 15864.4 15895.8 14257.6 14392.7 14404.4 14416.1 14430.3 685.0 708.4 709.7 848.3 863.1 790.4 824.7 872.9 884.7 889.9 924.1 937.7 941.4 941.4 942.3 717.4 912.7 930.2 937.0 938.7 550.4 671.0 687.2 696.8 699.5 15070.6 15140.5 15162.8 15165.5 15167.0 11832.9 11845.3 11954.9 11977.3 12179.3 12212.6 12299.8 12463.5 12472.6 12559.2 4185.4 4477.6 4481.9 4590.1 4630.5 97849.0 106774.5 106884.5 107143.0 107593.0 10461.7 10950.9 11133.9 11135.0 11324.0 21750.7 21937.5 21972.3 21984.1 22029.8 6909.2 7065.4 7096.0 7126.1 7170.0 4214.4 4270.5 4289.7 4324.1 4369.8 3433.3 3491.4 3506.2 3550.1 3556.9 651.8 656.5 657.4 660.5 714.1 644.2 648.3 648.4 652.0 681.8 8662.3 9735.8 9818.1 10092.9 10173.4 652.9 667.5 674.1 675.5 679.6 4716.3 4870.6 4871.1 4896.4 4919.4 87695.1 90438.1 100009.0 101044.5 102511.0 84669.7 90335.1 90706.5 92422.5 93399.5 53147.0 62367.7 63002.4 67447.0 67847.0 8851.2 10338.7 10653.6 10781.7 10870.1 36896.9 37652.4 43975.8 46405.8 47645.3 64143.4 65755.3 66571.7 67357.0 67486.7 12430.0 12753.2 12766.5 13034.9 13198.0 11963.3 12124.4 12670.5 13995.5 14287.4 11421.7 11549.4 12008.2 12184.0 12479.3 12734.0 13575.5 13717.9 13903.7 13941.2 12755.0 13581.9 13747.8 13878.0 13911.0 9926.6 10422.2 10862.3 10940.0 11436.5 8727.5 9359.6 10259.4 11150.7 11210.3 09:29:56 INFO - PROCESS | 1637 | -------- Summary: end -------- 09:29:56 INFO - PROCESS | 1637 | 09:29:57 INFO - TEST-INFO | 1637: exit 0 09:29:57 INFO - TEST-OK | dromaeo_css | took 1119174ms 09:29:57 INFO - TEST-START | kraken 09:29:57 INFO - operating with platform_type : mac_ 09:29:57 INFO - Initialising browser for kraken test... 09:29:57 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpHVAf8U/profile http://localhost:49241/getInfo.html) 09:29:59 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 09:29:59 INFO - PROCESS | 1647 | colorDepth:24 09:29:59 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 09:29:59 INFO - PROCESS | 1647 | __metrics 09:29:59 INFO - PROCESS | 1647 | 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" 09:29:59 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:30:00 INFO - TEST-INFO | 1647: exit 0 09:30:00 INFO - Browser initialized. 09:30:00 INFO - Running cycle 1/1 for kraken test... 09:30:00 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpHVAf8U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:12 INFO - PROCESS | 1649 | RSS: Main: 213348352 09:30:12 INFO - PROCESS | 1649 | 09:30:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:16 INFO - PROCESS | 1649 | RSS: Main: 265781248 09:30:16 INFO - PROCESS | 1649 | 09:30:19 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:30:19 INFO - PROCESS | 1649 | RSS: Main: 274853888 09:30:19 INFO - PROCESS | 1649 | 09:30:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:30:23 INFO - PROCESS | 1649 | RSS: Main: 372469760 09:30:23 INFO - PROCESS | 1649 | 09:30:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:30:26 INFO - PROCESS | 1649 | RSS: Main: 275828736 09:30:26 INFO - PROCESS | 1649 | 09:30:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:30:28 INFO - PROCESS | 1649 | RSS: Main: 277024768 09:30:28 INFO - PROCESS | 1649 | 09:30:31 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:30:32 INFO - PROCESS | 1649 | RSS: Main: 318300160 09:30:32 INFO - PROCESS | 1649 | 09:30:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:30:35 INFO - PROCESS | 1649 | RSS: Main: 318853120 09:30:35 INFO - PROCESS | 1649 | 09:30:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:30:39 INFO - PROCESS | 1649 | RSS: Main: 317435904 09:30:39 INFO - PROCESS | 1649 | 09:30:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:30:41 INFO - PROCESS | 1649 | RSS: Main: 294789120 09:30:41 INFO - PROCESS | 1649 | 09:30:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:30:43 INFO - PROCESS | 1649 | RSS: Main: 299802624 09:30:43 INFO - PROCESS | 1649 | 09:30:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:30:46 INFO - PROCESS | 1649 | RSS: Main: 301416448 09:30:46 INFO - PROCESS | 1649 | 09:30:49 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:30:50 INFO - PROCESS | 1649 | RSS: Main: 317841408 09:30:50 INFO - PROCESS | 1649 | 09:30:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:30:54 INFO - PROCESS | 1649 | RSS: Main: 311685120 09:30:54 INFO - PROCESS | 1649 | 09:30:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:30:56 INFO - PROCESS | 1649 | RSS: Main: 356036608 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | __start_tp_report 09:30:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 09:30:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 09:30:56 INFO - PROCESS | 1649 | |i|pagename|runs| 09:30:56 INFO - PROCESS | 1649 | |0;ai-astar;161;168;169;114;113;114;114;114;114;114 09:30:56 INFO - PROCESS | 1649 | |1;audio-beat-detection;139;109;109;148;144;140;108;113;127;108 09:30:56 INFO - PROCESS | 1649 | |2;audio-dft;185;184;184;185;185;185;185;190;184;185 09:30:56 INFO - PROCESS | 1649 | |3;audio-fft;83;59;58;87;59;61;60;61;92;85 09:30:56 INFO - PROCESS | 1649 | |4;audio-oscillator;88;71;83;69;67;68;81;68;69;102 09:30:56 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;84;87;85;100;132;88;84;87;85 09:30:56 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;92;102;142;108;93;93;93;93;94 09:30:56 INFO - PROCESS | 1649 | |7;imaging-desaturate;83;84;85;85;86;87;88;88;82;85 09:30:56 INFO - PROCESS | 1649 | |8;json-parse-financial;57;55;53;55;55;58;59;58;57;58 09:30:56 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;64;69;68;83;73;71;68;71;69;71 09:30:56 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;88;86;99;101;84;84;83;86;83;83 09:30:56 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;142;139;142;139;145;129;143;142;183;147 09:30:56 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;162;146;205;234;177;169;169;167;168;169 09:30:56 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;67;67;68;79;68;58;80;86;86;86 09:30:56 INFO - PROCESS | 1649 | __end_tp_report 09:30:56 INFO - PROCESS | 1649 | __start_cc_report 09:30:56 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1990 09:30:56 INFO - PROCESS | 1649 | __end_cc_report 09:30:56 INFO - PROCESS | 1649 | __startTimestamp1486056656134__endTimestamp 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | ------- Summary: start ------- 09:30:56 INFO - PROCESS | 1649 | Number of tests: 14 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:129.50 Median:114.00 stddev:25.27 (22.2%) stddev-sans-first:24.10 09:30:56 INFO - PROCESS | 1649 | Values: 161.0 168.0 169.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:133.00 stddev:16.82 (12.6%) stddev-sans-first:17.00 09:30:56 INFO - PROCESS | 1649 | Values: 139.0 109.0 109.0 148.0 144.0 140.0 108.0 113.0 127.0 108.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.00 stddev:1.75 (0.9%) stddev-sans-first:1.86 09:30:56 INFO - PROCESS | 1649 | Values: 185.0 184.0 184.0 185.0 185.0 185.0 185.0 190.0 184.0 185.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:70.50 Median:72.00 stddev:14.19 (19.7%) stddev-sans-first:14.31 09:30:56 INFO - PROCESS | 1649 | Values: 83.0 59.0 58.0 87.0 59.0 61.0 60.0 61.0 92.0 85.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:70.00 stddev:11.65 (16.6%) stddev-sans-first:11.61 09:30:56 INFO - PROCESS | 1649 | Values: 88.0 71.0 83.0 69.0 67.0 68.0 81.0 68.0 69.0 102.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:86.00 stddev:14.80 (17.2%) stddev-sans-first:15.63 09:30:56 INFO - PROCESS | 1649 | Values: 88.0 84.0 87.0 85.0 100.0 132.0 88.0 84.0 87.0 85.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:93.00 stddev:15.50 (16.7%) stddev-sans-first:16.27 09:30:56 INFO - PROCESS | 1649 | Values: 94.0 92.0 102.0 142.0 108.0 93.0 93.0 93.0 93.0 94.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:2.00 (2.3%) stddev-sans-first:1.94 09:30:56 INFO - PROCESS | 1649 | Values: 83.0 84.0 85.0 85.0 86.0 87.0 88.0 88.0 82.0 85.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.50 stddev:1.90 (3.3%) stddev-sans-first:2.01 09:30:56 INFO - PROCESS | 1649 | Values: 57.0 55.0 53.0 55.0 55.0 58.0 59.0 58.0 57.0 58.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:4.97 (7.0%) stddev-sans-first:4.64 09:30:56 INFO - PROCESS | 1649 | Values: 64.0 69.0 68.0 83.0 73.0 71.0 68.0 71.0 69.0 71.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.00 stddev:6.70 (7.9%) stddev-sans-first:7.11 09:30:56 INFO - PROCESS | 1649 | Values: 88.0 86.0 99.0 101.0 84.0 84.0 83.0 86.0 83.0 83.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:142.50 stddev:14.17 (9.9%) stddev-sans-first:14.98 09:30:56 INFO - PROCESS | 1649 | Values: 142.0 139.0 142.0 139.0 145.0 129.0 143.0 142.0 183.0 147.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:169.00 stddev:24.92 (14.7%) stddev-sans-first:25.87 09:30:56 INFO - PROCESS | 1649 | Values: 162.0 146.0 205.0 234.0 177.0 169.0 169.0 167.0 168.0 169.0 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:79.50 stddev:10.09 (12.7%) stddev-sans-first:10.33 09:30:56 INFO - PROCESS | 1649 | Values: 67.0 67.0 68.0 79.0 68.0 58.0 80.0 86.0 86.0 86.0 09:30:56 INFO - PROCESS | 1649 | -------- Summary: end -------- 09:30:56 INFO - PROCESS | 1649 | 09:30:56 INFO - TEST-INFO | 1649: exit 0 09:30:57 INFO - TEST-OK | kraken | took 59468ms 09:30:57 INFO - SUITE-END | took 1178s 09:30:57 INFO - Completed test suite (00:19:38) 09:30:57 INFO - javascript benchmark 09:30:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.9338813223735, 3323.185819474229, 3325.7006869381757, 3364.899053028407, 3385.5429517015195, 4701.905961880769, 5690.943090569093, 5709.971450142754, 5749.597528173019, 5773.5092517136045, 5697.715114244292, 5750.338711048231, 5768.653880767147, 5772.769089236436, 5780.219670344512, 4351.26028575143, 5219.686818790875, 5227.555657769094, 5243.554297884665, 5249.5012973767625, 5153.896922061575, 5186.247994040862, 5194.27280180775, 5254.133068043769, 5327.413984461706, 5290.6825590464505, 5294.947050529503, 5298.655587386807, 5301.204819277101, 5303.761330740126, 5254.553362964152, 5254.894902101936, 5257.395399529046, 5259.921101183485, 5264.052470555299, 5098.388193416777, 5200.531952124327, 5204.479552044803, 5205.583553315726, 5264.789408423659, 5772.624779389326, 5779.3642699303045, 5781.248437703114, 5785.2189954356045, 5812.534997200214, 6139.001538246403, 6145.877082458326, 6168.0439531872635, 6184.288806787187, 6190.96904515479, 6281.3404592518045, 6296.087067375205, 6301.212348456443, 6309.5898766580485, 6312.305646378894, 5775.826725198251, 5795.072788353843, 5795.072788353886, 5868.618539794899, 5880.617759845682, 5211.8175863845345, 6191.597546159485, 6256.249250090018, 6270.2475702915945, 6275.497960163268, 6105.308121371101, 6220.03589443637, 6225.657588832658, 6230.252369715572, 6238.812835614939, 6210.596311239755, 6256.468200203034, 6273.592216505913, 6277.780277690259, 6294.496440284766, 6133.907991380132, 6234.657093859882, 6250.624962502265, 6252.218472690914, 6275.96862015687, 6142.590862071594, 6145.016797312409, 6153.861535615925, 6203.937960620336, 6209.161763162006, 4973.42805577356, 4977.726225057584, 4981.501849814989, 4983.700977941335, 5011.574016208663, 4420.624246938982, 4420.624246938982, 4423.977880110579, 4427.977860110744, 4466.665000125004, 5629.493345598916, 5697.772089116389, 5707.8858422832145, 5735.684537350486, 5800.477956983892, 6213.906791398133, 6223.066540019034, 6239.0953311770445, 6256.655883926428, 6265.686715664198, 5809.651420914759, 5813.832087938302, 5818.621789583748, 5822.621529600562, 5878.559108066826, 5334.413214546396, 5336.519713225828, 5467.343918729778, 5484.314460692413, 5503.834884953458, 6211.503079753699, 6214.161088253209, 6233.96883015582, 6254.4996400286955, 6304.7162877671535, 5109.591232701449, 6157.983932651063, 6197.566170368031, 6203.534734894991, 6299.559030867796, 6161.84595385119, 6265.404786545271, 6306.180196574416, 6307.90538141919, 6309.747610095728, 6232.719527621359, 6235.594686345373, 6263.592866463665, 6263.655498947602, 6281.152044473937, 6070.2412198475195, 6110.5587591967305, 6133.548895741652, 6154.9384506154365, 6318.241810982528, 6135.722664536972, 6156.5998210116195, 6167.814965551041, 6169.56813023084, 6172.22847144107, 6135.294441139326, 6136.877262454636, 6142.938570614237, 6144.863200307957, 6146.78486252979, 5774.162746401832, 5777.0, 5846.795362162304, 5921.259842519685, 5948.851278718067, 6017.2779266488305, 6096.847578810565, 6098.512119030555, 6112.572119951738, 6119.0, 5902.085176797603, 5924.170616113662, 5932.733027013708, 5934.376890426615, 5945.078512830518], "value": 5696.9062189970045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.395571800941, 495.764511856868, 498.3396998976355, 509.6407033041706, 509.9031184075027, 30770.53844192336, 40443.79778101109, 41918.0, 42106.7894660527, 42124.157516849686, 35088.82455587725, 42170.36744448836, 42400.57599424005, 42546.57453425472, 42758.0, 9126.54367281635, 9307.674231401903, 9335.159835614793, 9341.906580934206, 9359.157675809176, 8281.668733250663, 8547.487150770943, 8555.871661925075, 8631.654733810672, 8645.827083458327, 11000.449977501134, 11276.887231127706, 11289.830652540219, 11414.885851141507, 11449.656510304705, 11114.388708621023, 11182.832257516144, 11202.775944481145, 11219.326840389604, 11247.493862776113, 8278.296344810698, 8497.277731392838, 11096.1123110151, 11182.105431565455, 11199.776004479865, 39997.60002399968, 40578.0, 40922.590774092474, 42554.0, 42707.14585708269, 3887.3455026165816, 4004.5594984551676, 4004.65960393364, 4035.0, 4136.5417792714015, 28920.855395723098, 28981.85509072462, 28995.565066524017, 29241.41517169666, 30146.397072058655, 3111.2688518198206, 3315.187778994162, 3380.645032271625, 3384.881529146468, 3386.5766779152605, 470851.0, 471670.0, 475746.0, 476649.0, 476859.0, 62460.0, 62685.0, 62926.0, 62966.37033629697, 63028.36971630225, 65586.67206664031, 65706.0144097839, 65711.0, 65898.34101658923, 65933.0, 16746.0, 16881.32474701023, 16945.49163525096, 16962.660746784994, 17007.659846802995, 12955.0, 13086.14940028895, 13185.208887466782, 13224.735505290033, 13225.735485290434, 13702.45190192381, 14400.495982640767, 14789.594988476078, 16495.670086598202, 21310.573788524143, 8648.308135349156, 8814.735557933143, 8827.823443531093, 8837.867431988525, 8877.511736854405, 755.8563872864138, 880.6169316347409, 905.8902844016028, 908.9863652045225, 912.8904531456268, 26172.8691356542, 29402.558961615592, 29558.96543620963, 30371.92549550286, 30851.382972340427, 1044.9477526123662, 1076.9138468922467, 1078.1967434261526, 1103.200179869588, 1117.6200091968608, 15549.611259718371, 15587.908846380871, 15632.531024069296, 15841.970271932287, 15902.68194636124, 587640.0, 592014.0, 592454.0, 593503.0, 593666.0, 62063.6896815513, 62392.37607623866, 62674.0, 62678.686606567586, 62805.0, 1287.5493577248076, 1433.3549902543898, 1444.9638759031109, 1478.8003619511658, 1483.473366954737, 24790.0, 29157.70842291635, 30109.849450752605, 30177.396452070396, 30177.698223017487, 41271.58728412678, 51545.48454515407, 51811.74094129505, 51889.0, 51942.48057519377, 578388.0, 578591.0, 588619.0, 589858.0507097609, 590790.0, 42790.93022674458, 42974.355384668626, 43743.56256437395, 43778.343324850786, 43819.34270985874, 46754.0, 47062.76468617635, 47136.52863471321, 47483.050338993715, 47847.76076119597, 33578.49632255567, 38766.80616596899, 39196.21607567776, 39201.80399097986, 39546.83625310026, 38568.6143138565, 38690.6130938687, 38691.613083868804, 38758.837234883, 38903.0, 36581.63418365782, 37321.44017839789, 38151.0, 38160.61839381682, 38363.0, 30766.38467230598, 33941.03531707651, 34211.657883421845, 34395.65604344025, 34492.82753586216, 20974.580508390052, 24461.51076978486, 24875.0, 24962.750372496044, 25157.0], "value": 20412.71414273136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.41826803094585, 372.6385406156028, 390.5762247960962, 400.4493820996131, 424.67300178862274, 14764.704705905875, 15484.922575387121, 18453.815461845377, 20964.58070838586, 20995.95020248989, 21584.460388490297, 21712.3486295411, 22076.448088797788, 22213.44466388337, 22356.10575576979, 5457.208704737811, 5791.768329266845, 5966.164736936832, 6039.5772295939305, 6110.236220472441, 4221.24017676818, 5881.470667639912, 5985.730642121115, 5989.490893274055, 5998.5800993930225, 4407.603315701586, 6231.563790534665, 6479.773207937723, 6508.967455162741, 6602.075709400688, 6336.112944187817, 6566.868662626721, 6578.901316480256, 6617.073609694647, 6644.568103073285, 5742.339630942453, 5816.098504731774, 5826.504747096502, 5827.766889324422, 5833.912491312633, 20973.68539471909, 21223.151073957022, 26287.868560657265, 26306.21081367562, 26607.866960665266, 2806.761425278854, 2829.349249672566, 2833.9008134715186, 2841.815282006663, 2872.6696429910617, 13109.47562097515, 15417.306221220071, 15468.30392632323, 15848.841511584968, 15963.910973755632, 1568.6705791783738, 1799.9190036448392, 1805.0201191769827, 1812.7401455988092, 1829.8746271043212, 96334.0, 122962.0, 125411.0, 128431.0, 153563.23218383838, 18555.628887422445, 18891.62216755685, 23596.0, 23624.291271261547, 24140.70663286985, 41155.0, 41172.38241426381, 41821.95445113836, 42067.78966105211, 42398.940026499586, 8648.221660050625, 8974.820503589892, 9161.816763664823, 9170.358074934824, 9246.121618446237, 7367.8894816577795, 8793.912060879436, 8885.289176865836, 8901.109889011048, 9130.497822619687, 4783.497732738082, 4841.353939660532, 4859.80560777572, 4893.828715994923, 4972.353594032825, 1770.9911450442664, 1840.9723854142198, 1943.5335519475225, 2011.3764732932837, 2057.567910738732, 960.1790469148917, 996.5067291690659, 1024.938503689766, 1031.417249254169, 1057.5875408590503, 21668.34994950154, 22161.445963851034, 22177.334679959626, 22285.220017299318, 22293.108275669118, 1051.4059556350637, 1051.8632577764843, 1054.1619412567027, 1056.7252514346326, 1059.7615536504225, 10749.516271767789, 11451.568553930758, 11475.71310717222, 11489.0, 11740.58907938218, 654625.0, 664678.0, 712240.0, 741448.0, 773146.0, 90747.58413532816, 145701.0, 149511.0, 155377.0, 164759.0, 1028.377831412, 1041.3127335958231, 1062.049465728169, 1063.197286049028, 1063.7500187456096, 19592.804071959097, 20140.295089671792, 21515.354539363845, 21612.45968850791, 21667.0, 47897.0, 57989.710051449474, 58681.0, 61066.69466652638, 61665.0, 80346.0, 86987.56506217428, 87908.12091879256, 89870.65194022226, 91501.0, 8138.3082437993435, 8222.506649601042, 8236.34109271245, 8472.322214222724, 8504.617292221988, 7620.733274335372, 11797.820217978133, 12860.549880754128, 13289.003324750489, 13833.377498012815, 11291.491882865126, 11377.20359574855, 11690.590829320932, 11971.221870578385, 11983.28100313984, 9796.265280103878, 11273.943630281796, 11491.8276225855, 11501.597444089417, 11756.764864702487, 11332.093432525213, 11567.479463423997, 11714.76570468603, 11751.236169648946, 11764.35296058725, 7781.06627204739, 8258.958705206436, 8436.409451338348, 8491.23578877904, 8728.607212675317, 6176.66028368444, 8167.224113709188, 11267.887321126684, 11625.011873990466, 11994.820077698667], "value": 10535.182806311852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.7853264944958, 1375.6973465837516, 1418.9787153192703, 1438.5684294711584, 1451.9056261343005, 8047.678092876278, 8447.91552084479, 8466.619002144902, 8470.237678608924, 8477.0, 7370.336669699726, 7661.770146895588, 7673.079230492335, 7736.845263094735, 7765.805854853632, 2085.8748475091465, 2131.6589345704692, 2226.309843948373, 2348.3307257431634, 2349.2012715676665, 2328.9534209315802, 2378.2151889876386, 2385.916492922748, 2389.7729715676983, 2394.4851856850773, 2255.3234029790997, 2316.200910685819, 2316.3514216019544, 2317.1194945920524, 2317.9884100579475, 2043.7036629688687, 2132.083204222176, 2256.8307376946796, 2333.3583264602203, 2339.508703172336, 2306.308107567723, 2323.6630688550067, 2324.476992676651, 2330.149495434171, 2340.9297721068397, 8259.38054645904, 8349.666013359458, 8354.624041918129, 8358.122397148272, 8363.749087527323, 5004.573696496517, 5180.481951804827, 5183.974080129613, 5185.299984502081, 5233.2935053768015, 3181.427343078245, 3392.0332705178907, 3507.4914137449928, 3539.2744487380023, 3539.4513850353237, 1150.3098141115347, 1156.1733360647092, 1224.9877501224962, 1237.5730373021293, 1238.4179435665224, 10674.786504269949, 10744.14046876248, 10799.67600971972, 10812.0, 10813.026827585476, 3862.633049860259, 4668.323093151542, 4735.739534325645, 4742.857714268577, 4745.050989802054, 9455.763605909908, 9475.573599188054, 9476.241900647932, 9477.857832132524, 9481.194098501566, 5188.143956247177, 5257.290265814143, 5260.263563101169, 5264.842054738364, 5273.288106105703, 4585.839495617637, 4695.154872122982, 4698.600618947359, 4756.667033307635, 4780.737059461693, 3604.891853244407, 3714.4799728038097, 3714.888553343404, 3870.5161854768153, 3979.5821438749094, 1226.0804396702474, 1262.741138066694, 1269.9873001270055, 1271.6185144456626, 1283.0569531394417, 786.8087376655985, 854.3464249848746, 889.0975659705405, 895.3329769321897, 906.8911730592371, 5332.173513105475, 5386.434424385383, 5408.0, 5626.915596266059, 5669.971650141723, 985.640241311916, 994.3437331361267, 996.1731762636994, 1022.4529876516028, 1037.725002874239, 3560.5193298904833, 3692.409214525717, 3702.4631428442726, 3711.406175011985, 3835.328817456934, 9597.712068637813, 9950.80098398028, 9966.352187107816, 9974.202063834875, 10018.849717254247, 9401.153896149242, 9841.803163936682, 9842.261830362751, 9847.507624618884, 9847.950760246153, 7667.8849817252785, 7728.613569321511, 7733.110692270348, 7877.291043806085, 7882.172371900982, 4554.578736333603, 5448.809291674931, 5458.972705136449, 5696.743646535833, 5804.506616937439, 8541.786455338666, 8803.867941980747, 8889.288856891304, 8997.55012249398, 9094.045125262017, 9071.047540008469, 9173.77065573366, 9199.494027828534, 9267.953660231655, 9389.483578403253, 6566.606003639797, 6648.700808463727, 6648.767293144717, 6656.633885136364, 6671.33286671329, 6941.757038503628, 7043.119610048744, 7054.788356349318, 7101.39638130744, 7166.211716711262, 6457.354264573505, 6497.512686548623, 6517.4134327910715, 6560.048792925095, 6591.373819487141, 6396.808095757135, 6436.613803171825, 6451.70967306463, 6476.481881449567, 6484.416402523795, 5799.188113664006, 5905.40945905406, 5907.0, 5909.172715819875, 5918.674472904032, 4591.127685739699, 4607.539246075366, 4647.419072615923, 4648.535146485325, 4668.463126740468, 4543.909121817611, 4561.338605902192, 4641.6286697064825, 4772.761361931959, 4812.374391329105], "value": 4327.486031519495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.8290737538606, 357.9821008949552, 359.52004074560466, 370.6460330384483, 371.120444546425, 4453.821847126115, 5100.908627462741, 5157.355330583672, 5164.922526162101, 5204.245384419257, 3783.5081439412907, 4190.182914331706, 4929.383827021622, 4977.05894701066, 4986.279733491949, 3367.478040903664, 3963.881083567483, 4019.2564375590464, 4083.367078102884, 4083.8570650027254, 4005.4192142139373, 4038.5557588665224, 4054.97972510137, 4060.4112403701447, 4105.9615884245595, 3175.666555011725, 3692.8892133236045, 3763.604821493731, 3853.4797802296753, 3900.9219815603815, 3139.022415878005, 3559.394902866493, 3991.7804520751347, 4020.4974378202724, 4029.9573821764675, 2954.9509923976893, 3352.513885486591, 3584.888684507811, 3599.766015209003, 3615.439606860941, 4136.896577585554, 4152.4601801765575, 4971.204607262821, 4997.225430058346, 5011.298418221452, 4089.9182016359505, 4378.8029538670835, 4609.3777340059, 4645.303204519315, 4651.418572678415, 5005.449400565934, 5080.314157588752, 5458.226076525106, 5490.646619545951, 5502.697351645658, 4016.096378314885, 4021.296273152216, 4023.8591649292134, 4026.7583944963394, 4031.5363733170766, 5601.579881508903, 5666.518345940642, 5669.744861481243, 5672.716364181774, 5757.136429535603, 3590.9461358079648, 4050.3721923101966, 4052.8986775330263, 4090.1819636072905, 4095.877123686294, 3655.9634403655623, 3803.752756070902, 3822.50307460034, 3968.6428221460205, 4141.109661422808, 4168.458100446923, 4237.618614324664, 4641.721496710208, 4675.836345727883, 4715.24556071027, 4621.69958952667, 4628.884277893079, 5496.268675367247, 5497.065498865202, 5546.278983732089, 1334.3061607963805, 1344.5294147048455, 1353.7630914589906, 1354.4243696428978, 1357.7895426208954, 855.6192494340083, 887.8446271902392, 904.5115637555647, 933.776752454287, 952.5618215620754, 3993.7204395692024, 4084.509858816961, 4529.750863702528, 4654.557817007447, 4770.141374552544, 4477.70894891831, 4865.270209468537, 5169.9741501293, 5221.738913054408, 5254.0805359062015, 4086.833977991669, 4668.439787225487, 4694.502595566325, 4725.480197178307, 4741.57325840676, 2494.837835540684, 2498.900483787128, 2533.70862350832, 2702.932426689309, 2796.678381986057, 4708.0, 5304.814331498456, 5410.701431656375, 5478.91781623276, 5526.861828454321, 4591.770411479412, 4900.373723444625, 5017.874553136201, 5440.755166017539, 5648.717564121777, 4859.659823812299, 5257.2902658140665, 5316.627836051439, 5750.827475175752, 5754.367019627922, 4713.387259656222, 4828.961773218774, 5534.280543529477, 5567.220589117608, 5574.498295153456, 4636.976815115903, 4706.458757242824, 4894.779734912009, 5279.340082489689, 5472.91790623149, 5059.519345662156, 5343.11838546651, 5700.059490184073, 5710.2862142232225, 5721.656700597978, 3625.803484850046, 3640.7451478396256, 3644.6902013328104, 3661.2860492203763, 3671.8347674355255, 4682.274247491644, 4789.592884604708, 5155.845324640267, 5561.63849349791, 5690.451809485884, 4712.59942904857, 5206.193040078794, 5400.783968641211, 5425.267588875609, 5443.455654434525, 4290.356446533045, 5304.708241046779, 5306.363236411501, 5351.153851921081, 5403.351597808131, 5032.0, 5134.794608215779, 5166.638335316642, 5184.533391994739, 5228.738563071907, 4419.80110895017, 4872.585830204473, 5290.44450332725, 5292.603054770831, 5323.600729945192, 5000.924986125284, 5265.578753699771, 5291.841244762663, 5304.655197412156, 5363.5440987516495], "value": 3934.881422745882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5828637199362, 733.493889216441, 769.5267410542515, 817.5503473089801, 829.0672992883007, 14869.256537173153, 15811.525654230363, 15831.683366332667, 15864.444744433933, 15895.841041589581, 14257.643558911032, 14392.71214575708, 14404.423823047066, 14416.062955907859, 14430.278486075707, 685.0477835808231, 708.4438715608248, 709.6735501669212, 848.295914391054, 863.0592654007115, 790.3992965346349, 824.742268041239, 872.899616544096, 884.6594061286419, 889.884315039044, 924.1497822003772, 937.6671281695002, 941.3598752848061, 941.38809773647, 942.3403617467766, 717.4224749076991, 912.6942474271127, 930.1767935377172, 937.0020927711965, 938.699616122841, 550.3780727777626, 670.9630970296631, 687.2440315652742, 696.7631005458118, 699.464909344352, 15070.623234419118, 15140.545783626509, 15162.772558411632, 15165.469208577757, 15167.0, 11832.88167118335, 11845.348505832177, 11954.880451195464, 11977.341246231454, 12179.269243845309, 12212.633620991384, 12299.754004919852, 12463.501459941592, 12472.563460278938, 12559.246445213317, 4185.372194170868, 4477.619402350804, 4481.932771008405, 4590.081983603292, 4630.467496237942, 97849.0, 106774.46612766964, 106884.46557767161, 107143.0, 107593.0, 10461.70456306261, 10950.890491095146, 11133.888661113448, 11135.0, 11324.0, 21750.673739893915, 21937.451563711034, 21972.340829775134, 21984.120635174735, 22029.779702203094, 6909.239983601799, 7065.399441047466, 7095.9645201773665, 7126.093874303857, 7169.96415017932, 4214.354370423226, 4270.530241673413, 4289.722313099158, 4324.070324880103, 4369.825206991684, 3433.261848702541, 3491.4064609016527, 3506.2461570762407, 3550.094725844893, 3556.893293201208, 651.8402991267075, 656.4649810404505, 657.385344702695, 660.5310229736845, 714.0610097721479, 644.2494493914537, 648.2868844271264, 648.4229036157823, 651.9706613202417, 681.8011911585197, 8662.263707584925, 9735.805283894424, 9818.067283608189, 10092.899071009197, 10173.389596624227, 652.9053287273414, 667.549404152205, 674.130371820356, 675.5001299038775, 679.6363945289246, 4716.316134160596, 4870.6103511718975, 4871.074495845778, 4896.36347274852, 4919.434265059564, 87695.1230487687, 90438.09561904428, 100009.0, 101044.49477752564, 102511.0, 84669.72995405074, 90335.09664903267, 90706.54646726724, 92422.53788731013, 93399.53300233456, 53147.0, 62367.68816156072, 63002.369976300564, 67447.0, 67846.98229526561, 8851.203391694778, 10338.689839304832, 10653.598994080954, 10781.679206975012, 10870.130389568658, 36896.89309320725, 37652.43521347237, 43975.78012109919, 46405.83985400392, 47645.28532071952, 64143.358566413735, 65755.34244657493, 66571.66714166592, 67357.0, 67486.66256668685, 12430.0, 12753.171043882117, 12766.489340426278, 13034.934825325812, 13198.0, 11963.342016189194, 12124.393780311126, 12670.542887568048, 13995.51015714445, 14287.42850285977, 11421.714457138638, 11549.36478493691, 12008.159428839897, 12184.025277977918, 12479.251244925334, 12734.0, 13575.456981720621, 13717.862821371658, 13903.652408689459, 13941.233232172328, 12755.043371746971, 13581.86418135806, 13747.813912237942, 13878.0, 13911.0, 9926.602935882484, 10422.166226701996, 10862.34825910448, 10940.0, 11436.485358158736, 8727.476351418934, 9359.613268745343, 10259.384436933808, 11150.665480035612, 11210.31845223223], "value": 7342.459829842971, "unit": "score"}], "name": "dromaeo_css", "value": 7314.879812522525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 168.0, 169.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 129.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 109.0, 148.0, 144.0, 140.0, 108.0, 113.0, 127.0, 108.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 185.0, 185.0, 185.0, 185.0, 190.0, 184.0, 185.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 87.0, 59.0, 61.0, 60.0, 61.0, 92.0, 85.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 83.0, 69.0, 67.0, 68.0, 81.0, 68.0, 69.0, 102.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 100.0, 132.0, 88.0, 84.0, 87.0, 85.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 102.0, 142.0, 108.0, 93.0, 93.0, 93.0, 93.0, 94.0], "value": 100.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 85.0, 86.0, 87.0, 88.0, 88.0, 82.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 55.0, 55.0, 58.0, 59.0, 58.0, 57.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 68.0, 83.0, 73.0, 71.0, 68.0, 71.0, 69.0, 71.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 99.0, 101.0, 84.0, 84.0, 83.0, 86.0, 83.0, 83.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 142.0, 139.0, 145.0, 129.0, 143.0, 142.0, 183.0, 147.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 146.0, 205.0, 234.0, 177.0, 169.0, 169.0, 167.0, 168.0, 169.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 79.0, 68.0, 58.0, 80.0, 86.0, 86.0, 86.0], "value": 74.5, "unit": "score"}], "name": "kraken", "value": 1475.0999999999997, "alertThreshold": 2.0}]} 09:30:57 INFO - Return code: 0 09:30:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:30:57 ERROR - # TBPL SUCCESS # 09:30:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:30:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:30:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:30:57 INFO - 2017-02-02 09:30:57.427 screenresolution[1653:10023] starting screenresolution argv=screenresolution get 09:30:57 INFO - 2017-02-02 09:30:57.431 screenresolution[1653:10023] Display 0: 1600x1200x32@60 09:30:57 INFO - 2017-02-02 09:30:57.438 screenresolution[1654:10026] starting screenresolution argv=screenresolution list 09:30:57 INFO - Available Modes on Display 0 09:30:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:30:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:30:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:30:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:30:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:30:57 INFO - Intel Iris: 09:30:57 INFO - Chipset Model: Intel Iris 09:30:57 INFO - Type: GPU 09:30:57 INFO - Bus: Built-In 09:30:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:30:57 INFO - Vendor: Intel (0x8086) 09:30:57 INFO - Device ID: 0x0a2e 09:30:57 INFO - Revision ID: 0x0009 09:30:57 INFO - Displays: 09:30:57 INFO - Display: 09:30:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:30:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:30:57 INFO - Display Serial Number: 1600x1200 60 09:30:57 INFO - Main Display: Yes 09:30:57 INFO - Mirror: Off 09:30:57 INFO - Online: Yes 09:30:57 INFO - Rotation: Supported 09:30:57 INFO - Return code: 0 09:30:57 INFO - Running post-action listener: _resource_record_post_action 09:30:57 INFO - [mozharness: 2017-02-02 17:30:57.677237Z] Finished run-tests step (success) 09:30:57 INFO - Running post-run listener: _resource_record_post_run 09:30:57 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39273472; Write bytes: 509303808; Read time: 382; Write time: 1702 09:30:57 INFO - TinderboxPrint: CPU usage
53.6% 09:30:57 INFO - TinderboxPrint: I/O read bytes / time
39,273,472 / 382 09:30:57 INFO - TinderboxPrint: I/O write bytes / time
509,303,808 / 1,702 09:30:57 INFO - TinderboxPrint: CPU idle
2,225.2 (46.4%) 09:30:57 INFO - TinderboxPrint: CPU system
961.5 (20.0%) 09:30:57 INFO - TinderboxPrint: CPU user
1,610.9 (33.6%) 09:30:57 INFO - TinderboxPrint: Swap in / out
246,550,528 / 0 09:30:57 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205337088; Write bytes: 202639360; Read time: 15722; Write time: 426 09:30:57 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37184512; Write bytes: 295707648; Read time: 354; Write time: 1228 09:30:58 INFO - Running post-run listener: _upload_blobber_files 09:30:58 INFO - Blob upload gear active. 09:30:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:30:58 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 09:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:30:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:59 INFO - (blobuploader) - INFO - Done attempting. 09:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:00 INFO - (blobuploader) - INFO - Done attempting. 09:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:01 INFO - (blobuploader) - INFO - Done attempting. 09:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:03 INFO - (blobuploader) - INFO - Done attempting. 09:31:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:03 INFO - Return code: 0 09:31:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25e3ccef25965882adbf32e412def19a83f7cdd437d3f3e06377815a266cf37531d5733b5a2e8b9b8ef1b64d1ec7bbd4f8fefa586c70bf3e382ffe4f4d5c6832", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b927fb1fa30b744f10699a7cb67055c54123fdb1f1e31ec244b82822a3a8ba7fecb451981cddaee68c4e49415e35adb25e514a47b9fdc5f7baf2188639acef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fd2097995cdde8dd79b9018df285ddaa66aa0b6fdae7c77db36b53dd202d30136cafc8bc687a03daa51441dfb30da0dbf5347671b94826819793d90ea072bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af0739152ae6aad4d08dedde4e132cdaa3eec05d86d0a6c5889b907cf0dea82fd990f9f43ae9d6c7393487ceb5ca42c99a9b54f27b560c3720f6aa46aa093530"} 09:31:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:03 INFO - Contents: 09:31:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25e3ccef25965882adbf32e412def19a83f7cdd437d3f3e06377815a266cf37531d5733b5a2e8b9b8ef1b64d1ec7bbd4f8fefa586c70bf3e382ffe4f4d5c6832", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b927fb1fa30b744f10699a7cb67055c54123fdb1f1e31ec244b82822a3a8ba7fecb451981cddaee68c4e49415e35adb25e514a47b9fdc5f7baf2188639acef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fd2097995cdde8dd79b9018df285ddaa66aa0b6fdae7c77db36b53dd202d30136cafc8bc687a03daa51441dfb30da0dbf5347671b94826819793d90ea072bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af0739152ae6aad4d08dedde4e132cdaa3eec05d86d0a6c5889b907cf0dea82fd990f9f43ae9d6c7393487ceb5ca42c99a9b54f27b560c3720f6aa46aa093530"} 09:31:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:03 INFO - Copying logs to upload dir... 09:31:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.739966 ========= master_lag: 1.48 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-02 09:31:05.240286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 09:31:05.247828) ========= 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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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/Mozilla-Aurora/sha512/25e3ccef25965882adbf32e412def19a83f7cdd437d3f3e06377815a266cf37531d5733b5a2e8b9b8ef1b64d1ec7bbd4f8fefa586c70bf3e382ffe4f4d5c6832", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b927fb1fa30b744f10699a7cb67055c54123fdb1f1e31ec244b82822a3a8ba7fecb451981cddaee68c4e49415e35adb25e514a47b9fdc5f7baf2188639acef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fd2097995cdde8dd79b9018df285ddaa66aa0b6fdae7c77db36b53dd202d30136cafc8bc687a03daa51441dfb30da0dbf5347671b94826819793d90ea072bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af0739152ae6aad4d08dedde4e132cdaa3eec05d86d0a6c5889b907cf0dea82fd990f9f43ae9d6c7393487ceb5ca42c99a9b54f27b560c3720f6aa46aa093530"} build_url:https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/Da-brY_TTVSzgxm_bnGodg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25e3ccef25965882adbf32e412def19a83f7cdd437d3f3e06377815a266cf37531d5733b5a2e8b9b8ef1b64d1ec7bbd4f8fefa586c70bf3e382ffe4f4d5c6832", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b927fb1fa30b744f10699a7cb67055c54123fdb1f1e31ec244b82822a3a8ba7fecb451981cddaee68c4e49415e35adb25e514a47b9fdc5f7baf2188639acef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fd2097995cdde8dd79b9018df285ddaa66aa0b6fdae7c77db36b53dd202d30136cafc8bc687a03daa51441dfb30da0dbf5347671b94826819793d90ea072bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af0739152ae6aad4d08dedde4e132cdaa3eec05d86d0a6c5889b907cf0dea82fd990f9f43ae9d6c7393487ceb5ca42c99a9b54f27b560c3720f6aa46aa093530"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 09:31:05.293828) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 09:31:05.294204) ========= 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.8NPtBxXfJr/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.DI6qmp4eLa/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005032 ========= master_lag: 1.90 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 09:31:07.204103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 09:31:07.204442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 09:31:07.208319) ========= ========= Total master_lag: 3.50 =========