builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0288 starttime: 1484250618.75 results: success (0) buildid: 20170112094717 builduid: d9d7f55b08b8469ab8961ae9334dad27 revision: d55de1bf995f76bfbad5c1d3afdc3112710deb47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.750518) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.750946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.751220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.776946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.777391) ========= 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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-12 11:50:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.80M=0.001s 2017-01-12 11:50:18 (8.80 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.945575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.946234) ========= 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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.022123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:18.995279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 11:50:18.995664) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev d55de1bf995f76bfbad5c1d3afdc3112710deb47 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev d55de1bf995f76bfbad5c1d3afdc3112710deb47 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SyPjnvWdjH/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.GiaEH6aw8m/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-12 11:50:19,076 truncating revision to first 12 chars 2017-01-12 11:50:19,076 Setting DEBUG logging. 2017-01-12 11:50:19,076 attempt 1/10 2017-01-12 11:50:19,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/d55de1bf995f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 11:50:20,821 unpacking tar archive at: graphics-d55de1bf995f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.006763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 11:50:21.025848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:21.026212) ========= script_repo_revision: d55de1bf995f76bfbad5c1d3afdc3112710deb47 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:21.026668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:21.026970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 11:50:21.046435) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-12 11:50:21.046803) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SyPjnvWdjH/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.GiaEH6aw8m/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:50:21 INFO - MultiFileLogger online at 20170112 11:50:21 in /builds/slave/test 11:50:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 11:50:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:21 INFO - {'append_to_log': False, 11:50:21 INFO - 'base_work_dir': '/builds/slave/test', 11:50:21 INFO - 'blob_upload_branch': 'Graphics', 11:50:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:21 INFO - 'branch': 'Graphics', 11:50:21 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:21 INFO - 'config_files': ('talos/mac_config.py',), 11:50:21 INFO - 'default_actions': ('clobber', 11:50:21 INFO - 'read-buildbot-config', 11:50:21 INFO - 'download-and-extract', 11:50:21 INFO - 'populate-webroot', 11:50:21 INFO - 'create-virtualenv', 11:50:21 INFO - 'install', 11:50:21 INFO - 'run-tests'), 11:50:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:21 INFO - 'download_minidump_stackwalk': True, 11:50:21 INFO - 'download_symbols': 'ondemand', 11:50:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:50:21 INFO - 'tooltool.py': '/tools/tooltool.py', 11:50:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:50:21 INFO - '/tools/misc-python/virtualenv.py')}, 11:50:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:21 INFO - 'installer_path': 'installer.exe', 11:50:21 INFO - 'log_level': 'info', 11:50:21 INFO - 'log_name': 'talos', 11:50:21 INFO - 'log_to_console': True, 11:50:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:50:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:50:21 INFO - 'opt_config_files': (), 11:50:21 INFO - 'pip_index': False, 11:50:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:21 INFO - 'cmd': ('bash', 11:50:21 INFO - '-c', 11:50:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:21 INFO - 'enabled': True, 11:50:21 INFO - 'halt_on_failure': False, 11:50:21 INFO - 'name': 'check_screen_resolution'},), 11:50:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:21 INFO - 'cmd': ('bash', 11:50:21 INFO - '-c', 11:50:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:21 INFO - 'enabled': True, 11:50:21 INFO - 'halt_on_failure': False, 11:50:21 INFO - 'name': 'check_screen_resolution'},), 11:50:21 INFO - 'run_cmd_checks_enabled': True, 11:50:21 INFO - 'sps_profile': False, 11:50:21 INFO - 'sps_profile_interval': 0, 11:50:21 INFO - 'suite': 'dromaeojs', 11:50:21 INFO - 'system_bits': '32', 11:50:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:21 INFO - 'title': 't-yosemite-r7-0288', 11:50:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:21 INFO - 'use_talos_json': True, 11:50:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:21 INFO - 'work_dir': 'build'} 11:50:21 INFO - [mozharness: 2017-01-12 19:50:21.247380Z] Running clobber step. 11:50:21 INFO - Running pre-action listener: _resource_record_pre_action 11:50:21 INFO - Running main action method: clobber 11:50:21 INFO - rmtree: /builds/slave/test/build 11:50:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:23 INFO - Running post-action listener: _resource_record_post_action 11:50:23 INFO - [mozharness: 2017-01-12 19:50:23.342333Z] Finished clobber step (success) 11:50:23 INFO - [mozharness: 2017-01-12 19:50:23.342478Z] Running read-buildbot-config step. 11:50:23 INFO - Running pre-action listener: _resource_record_pre_action 11:50:23 INFO - Running main action method: read_buildbot_config 11:50:23 INFO - Using buildbot properties: 11:50:23 INFO - { 11:50:23 INFO - "project": "", 11:50:23 INFO - "product": "firefox", 11:50:23 INFO - "script_repo_revision": "default", 11:50:23 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 11:50:23 INFO - "repository": "", 11:50:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 11:50:23 INFO - "buildid": "20170112094717", 11:50:23 INFO - "pgo_build": "False", 11:50:23 INFO - "basedir": "/builds/slave/test", 11:50:23 INFO - "buildnumber": 3, 11:50:23 INFO - "slavename": "t-yosemite-r7-0288", 11:50:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:50:23 INFO - "platform": "yosemite_r7", 11:50:23 INFO - "scheduler": "tests-graphics-macosx64-talos", 11:50:23 INFO - "branch": "graphics", 11:50:23 INFO - "repo_path": "projects/graphics", 11:50:23 INFO - "revision": "d55de1bf995f76bfbad5c1d3afdc3112710deb47", 11:50:23 INFO - "stage_platform": "macosx64", 11:50:23 INFO - "builduid": "d9d7f55b08b8469ab8961ae9334dad27", 11:50:23 INFO - "slavebuilddir": "test" 11:50:23 INFO - } 11:50:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 11:50:23 INFO - Running post-action listener: _resource_record_post_action 11:50:23 INFO - [mozharness: 2017-01-12 19:50:23.345676Z] Finished read-buildbot-config step (success) 11:50:23 INFO - [mozharness: 2017-01-12 19:50:23.345761Z] Running download-and-extract step. 11:50:23 INFO - Running pre-action listener: _resource_record_pre_action 11:50:23 INFO - Running main action method: download_and_extract 11:50:23 INFO - mkdir: /builds/slave/test/build/tests 11:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:23 INFO - trying https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 11:50:23 INFO - Downloading https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 11:50:24 INFO - Downloaded 1199 bytes. 11:50:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:50:24 INFO - Using the following test package requirements: 11:50:24 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:50:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 11:50:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 11:50:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'jsshell-mac.zip'], 11:50:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 11:50:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:50:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 11:50:24 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 11:50:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 11:50:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:50:24 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 11:50:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:50:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:50:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:50:24 INFO - Fetch https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:50:25 INFO - Expected file size: 16314157 11:50:25 INFO - Obtained file size: 16314157 11:50:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:50:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:50:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:50:31 INFO - Fetch https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:50:33 INFO - Expected file size: 16314157 11:50:33 INFO - Obtained file size: 16314157 11:50:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 11:50:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:50:39 INFO - Fetch https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 11:50:40 INFO - Expected file size: 14403532 11:50:40 INFO - Obtained file size: 14403532 11:50:41 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')]} 11:50:41 INFO - trying https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:50:41 INFO - Downloading https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 11:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 11:50:43 INFO - Downloaded 70092023 bytes. 11:50:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:50:43 INFO - mkdir: /builds/slave/test/properties 11:50:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:50:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:50:43 INFO - Contents: 11:50:43 INFO - build_url:https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:50:44 INFO - Running post-action listener: _resource_record_post_action 11:50:44 INFO - Running post-action listener: set_extra_try_arguments 11:50:44 INFO - [mozharness: 2017-01-12 19:50:44.764698Z] Finished download-and-extract step (success) 11:50:44 INFO - [mozharness: 2017-01-12 19:50:44.764823Z] Running populate-webroot step. 11:50:44 INFO - Running pre-action listener: _resource_record_pre_action 11:50:44 INFO - Running main action method: populate_webroot 11:50:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:50:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:50:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:50:44 INFO - '--tppagecycles', 11:50:44 INFO - '7'], 11:50:44 INFO - 'tests': ['tsvgm']}}, 11:50:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:50:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:50:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:50:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:50:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:50:44 INFO - 'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:50:44 INFO - 'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['damp', 'tps']}, 11:50:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:50:44 INFO - 'tests': ['damp', 'tps']}, 11:50:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['dromaeo_dom']}, 11:50:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:50:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['basic_compositor_video']}, 11:50:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:50:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['a11yr', 11:50:44 INFO - 'ts_paint', 11:50:44 INFO - 'tpaint', 11:50:44 INFO - 'sessionrestore', 11:50:44 INFO - 'sessionrestore_no_auto_restore', 11:50:44 INFO - 'tabpaint']}, 11:50:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:50:44 INFO - 'ts_paint', 11:50:44 INFO - 'tpaint', 11:50:44 INFO - 'sessionrestore', 11:50:44 INFO - 'sessionrestore_no_auto_restore', 11:50:44 INFO - 'tabpaint']}, 11:50:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:50:44 INFO - 'ts_paint', 11:50:44 INFO - 'tpaint', 11:50:44 INFO - 'sessionrestore', 11:50:44 INFO - 'sessionrestore_no_auto_restore', 11:50:44 INFO - 'tabpaint']}, 11:50:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:50:44 INFO - 'ts_paint', 11:50:44 INFO - 'tpaint', 11:50:44 INFO - 'sessionrestore', 11:50:44 INFO - 'sessionrestore_no_auto_restore', 11:50:44 INFO - 'tabpaint']}, 11:50:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['a11yr', 11:50:44 INFO - 'ts_paint', 11:50:44 INFO - 'tpaint', 11:50:44 INFO - 'sessionrestore', 11:50:44 INFO - 'sessionrestore_no_auto_restore', 11:50:44 INFO - 'tabpaint']}, 11:50:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['a11yr', 11:50:44 INFO - 'ts_paint', 11:50:44 INFO - 'tpaint', 11:50:44 INFO - 'sessionrestore', 11:50:44 INFO - 'sessionrestore_no_auto_restore', 11:50:44 INFO - 'tabpaint']}, 11:50:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['tsvgx', 11:50:44 INFO - 'tsvgr_opacity', 11:50:44 INFO - 'tart', 11:50:44 INFO - 'tscrollx', 11:50:44 INFO - 'cart', 11:50:44 INFO - 'tsvg_static']}, 11:50:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:50:44 INFO - 'tsvgr_opacity', 11:50:44 INFO - 'tart', 11:50:44 INFO - 'tscrollx', 11:50:44 INFO - 'cart', 11:50:44 INFO - 'tsvg_static']}, 11:50:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:50:44 INFO - 'talos_options': ['--disable-e10s'], 11:50:44 INFO - 'tests': ['tp5o']}, 11:50:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:50:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:50:44 INFO - 'talos_options': ['--disable-e10s', 11:50:44 INFO - '--xperf_path', 11:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:44 INFO - 'tests': ['tp5n']}, 11:50:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:50:44 INFO - 'talos_options': ['--xperf_path', 11:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:44 INFO - 'tests': ['tp5n']}}, 11:50:44 INFO - 'talos.zip': {'path': '', 11:50:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:50:44 INFO - Running post-action listener: _resource_record_post_action 11:50:44 INFO - [mozharness: 2017-01-12 19:50:44.783448Z] Finished populate-webroot step (success) 11:50:44 INFO - [mozharness: 2017-01-12 19:50:44.783581Z] Running create-virtualenv step. 11:50:44 INFO - Running pre-action listener: _resource_record_pre_action 11:50:44 INFO - Running main action method: create_virtualenv 11:50:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:50:44 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 11:50:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:50:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:50:44 INFO - Using real prefix '/tools/python27' 11:50:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:50:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:50:48 INFO - Installing pip.................done. 11:50:48 INFO - Return code: 0 11:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:50:48 INFO - Reading from file tmpfile_stdout 11:50:48 INFO - Output received: 11:50:48 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) 11:50:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:50:48 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')]} 11:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:48 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')]} 11:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:48 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:50:48 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 11:50:48 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 11:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:48 INFO - 'HOME': '/Users/cltbld', 11:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:48 INFO - 'LOGNAME': 'cltbld', 11:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:48 INFO - 'MOZ_NO_REMOTE': '1', 11:50:48 INFO - 'NO_EM_RESTART': '1', 11:50:48 INFO - 'PAGER': '/bin/cat', 11:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:48 INFO - 'PWD': '/builds/slave/test', 11:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:48 INFO - 'SHELL': '/bin/bash', 11:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:50:48 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:48 INFO - 'USER': 'cltbld', 11:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:48 INFO - 'XPC_FLAGS': '0x0', 11:50:48 INFO - 'XPC_SERVICE_NAME': '0', 11:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:48 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 11:50:48 INFO - Cleaning up... 11:50:48 INFO - Return code: 0 11:50:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:50:48 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')]} 11:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:48 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')]} 11:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:48 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:50:48 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 11:50:48 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 11:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:48 INFO - 'HOME': '/Users/cltbld', 11:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:48 INFO - 'LOGNAME': 'cltbld', 11:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:48 INFO - 'MOZ_NO_REMOTE': '1', 11:50:48 INFO - 'NO_EM_RESTART': '1', 11:50:48 INFO - 'PAGER': '/bin/cat', 11:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:48 INFO - 'PWD': '/builds/slave/test', 11:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:48 INFO - 'SHELL': '/bin/bash', 11:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:50:48 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:48 INFO - 'USER': 'cltbld', 11:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:48 INFO - 'XPC_FLAGS': '0x0', 11:50:48 INFO - 'XPC_SERVICE_NAME': '0', 11:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:49 INFO - Downloading/unpacking psutil>=3.1.1 11:50:49 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 11:50:49 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 11:50:49 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 11:50:49 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 11:50:49 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 11:50:49 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 11:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:52 INFO - Installing collected packages: psutil 11:50:52 INFO - Running setup.py install for psutil 11:50:52 INFO - building 'psutil._psutil_osx' extension 11:50:52 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 11:50:53 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 11:50:53 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 11:50:53 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 11:50:53 INFO - building 'psutil._psutil_posix' extension 11:50:53 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 11:50:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:50:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:50:53 INFO - ^ 11:50:53 INFO - 1 warning generated. 11:50:53 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 11:50:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:53 INFO - Successfully installed psutil 11:50:53 INFO - Cleaning up... 11:50:53 INFO - Return code: 0 11:50:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:50:53 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')]} 11:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:53 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')]} 11:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:53 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:50:53 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 11:50:53 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 11:50:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:50:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:53 INFO - 'HOME': '/Users/cltbld', 11:50:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:53 INFO - 'LOGNAME': 'cltbld', 11:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:53 INFO - 'MOZ_NO_REMOTE': '1', 11:50:53 INFO - 'NO_EM_RESTART': '1', 11:50:53 INFO - 'PAGER': '/bin/cat', 11:50:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:53 INFO - 'PWD': '/builds/slave/test', 11:50:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:53 INFO - 'SHELL': '/bin/bash', 11:50:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:50:53 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:50:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:53 INFO - 'USER': 'cltbld', 11:50:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:53 INFO - 'XPC_FLAGS': '0x0', 11:50:53 INFO - 'XPC_SERVICE_NAME': '0', 11:50:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:50:54 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 11:50:54 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 11:50:54 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 11:50:54 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 11:50:54 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 11:50:54 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 11:50:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:50:56 INFO - Installing collected packages: mozsystemmonitor 11:50:56 INFO - Running setup.py install for mozsystemmonitor 11:50:56 INFO - Successfully installed mozsystemmonitor 11:50:56 INFO - Cleaning up... 11:50:57 INFO - Return code: 0 11:50:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:50: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==2.5.1'] in /builds/slave/test/build 11:50: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==2.5.1 11:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:57 INFO - 'HOME': '/Users/cltbld', 11:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:57 INFO - 'LOGNAME': 'cltbld', 11:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:57 INFO - 'MOZ_NO_REMOTE': '1', 11:50:57 INFO - 'NO_EM_RESTART': '1', 11:50:57 INFO - 'PAGER': '/bin/cat', 11:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:57 INFO - 'PWD': '/builds/slave/test', 11:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:57 INFO - 'SHELL': '/bin/bash', 11:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:50:57 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:57 INFO - 'USER': 'cltbld', 11:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:57 INFO - 'XPC_FLAGS': '0x0', 11:50:57 INFO - 'XPC_SERVICE_NAME': '0', 11:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:50:57 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 11:50:57 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 11:50:57 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 11:50:57 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 11:50:57 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 11:50:57 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 11:50:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:50:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:00 INFO - warning: no files found matching '*.txt' 11:51:00 INFO - no previously-included directories found matching 'build' 11:51:00 INFO - no previously-included directories found matching 'dist' 11:51:00 INFO - no previously-included directories found matching '.git*' 11:51:00 INFO - Installing collected packages: jsonschema, functools32 11:51:00 INFO - Running setup.py install for functools32 11:51:00 INFO - warning: no files found matching '*.txt' 11:51:00 INFO - no previously-included directories found matching 'build' 11:51:00 INFO - no previously-included directories found matching 'dist' 11:51:00 INFO - no previously-included directories found matching '.git*' 11:51:00 INFO - Successfully installed jsonschema functools32 11:51:00 INFO - Cleaning up... 11:51:00 INFO - Return code: 0 11:51:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:51:00 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')]} 11:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:00 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')]} 11:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:00 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:51:00 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 11:51:00 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 11:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:00 INFO - 'HOME': '/Users/cltbld', 11:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:00 INFO - 'LOGNAME': 'cltbld', 11:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:00 INFO - 'MOZ_NO_REMOTE': '1', 11:51:00 INFO - 'NO_EM_RESTART': '1', 11:51:00 INFO - 'PAGER': '/bin/cat', 11:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:00 INFO - 'PWD': '/builds/slave/test', 11:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:00 INFO - 'SHELL': '/bin/bash', 11:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:51:00 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:00 INFO - 'USER': 'cltbld', 11:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:00 INFO - 'XPC_FLAGS': '0x0', 11:51:00 INFO - 'XPC_SERVICE_NAME': '0', 11:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:51:00 INFO - Cleaning up... 11:51:00 INFO - Return code: 0 11:51:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:00 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')]} 11:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:00 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')]} 11:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:00 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:51:00 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 11:51:00 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 11:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:00 INFO - 'HOME': '/Users/cltbld', 11:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:00 INFO - 'LOGNAME': 'cltbld', 11:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:00 INFO - 'MOZ_NO_REMOTE': '1', 11:51:00 INFO - 'NO_EM_RESTART': '1', 11:51:00 INFO - 'PAGER': '/bin/cat', 11:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:00 INFO - 'PWD': '/builds/slave/test', 11:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:00 INFO - 'SHELL': '/bin/bash', 11:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:51:00 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:00 INFO - 'USER': 'cltbld', 11:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:00 INFO - 'XPC_FLAGS': '0x0', 11:51:00 INFO - 'XPC_SERVICE_NAME': '0', 11:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51:03 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 11:51:03 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 11:51:03 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 11:51:03 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 11:51:03 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 11:51:03 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 11:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:05 INFO - Downloading docopt-0.6.1.tar.gz 11:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:05 INFO - Running setup.py install for blobuploader 11:51:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:05 INFO - Running setup.py install for requests 11:51:05 INFO - Running setup.py install for docopt 11:51:06 INFO - Successfully installed blobuploader requests docopt 11:51:06 INFO - Cleaning up... 11:51:06 INFO - Return code: 0 11:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:06 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:51:06 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 11:51:06 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 11:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:06 INFO - 'HOME': '/Users/cltbld', 11:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:06 INFO - 'LOGNAME': 'cltbld', 11:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:06 INFO - 'MOZ_NO_REMOTE': '1', 11:51:06 INFO - 'NO_EM_RESTART': '1', 11:51:06 INFO - 'PAGER': '/bin/cat', 11:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:06 INFO - 'PWD': '/builds/slave/test', 11:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:06 INFO - 'SHELL': '/bin/bash', 11:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:51:06 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:06 INFO - 'USER': 'cltbld', 11:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:06 INFO - 'XPC_FLAGS': '0x0', 11:51:06 INFO - 'XPC_SERVICE_NAME': '0', 11:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:06 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-_ymDYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:06 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-kmBdX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:06 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-0uj1sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:06 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-pisOce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:06 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-h4iGwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:06 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-3Dmscx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-0Ea26r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-91PWMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Bn74dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-tra19B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-LjPkac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-You9U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-iy7YAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-HkkOGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-gABzI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:07 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-TG5uXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:08 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-JmrJnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:08 INFO - Running setup.py install for manifestparser 11:51:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:08 INFO - Running setup.py install for mozcrash 11:51:08 INFO - Running setup.py install for mozdebug 11:51:08 INFO - Running setup.py install for mozdevice 11:51:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:51:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:08 INFO - Running setup.py install for mozfile 11:51:08 INFO - Running setup.py install for mozhttpd 11:51:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Running setup.py install for mozinfo 11:51:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Running setup.py install for mozInstall 11:51:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Running setup.py install for mozleak 11:51:09 INFO - Running setup.py install for mozlog 11:51:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Running setup.py install for moznetwork 11:51:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:09 INFO - Running setup.py install for mozprocess 11:51:10 INFO - Running setup.py install for mozprofile 11:51:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:10 INFO - Running setup.py install for mozrunner 11:51:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:10 INFO - Running setup.py install for mozscreenshot 11:51:10 INFO - Running setup.py install for moztest 11:51:10 INFO - Running setup.py install for mozversion 11:51:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:10 INFO - Cleaning up... 11:51:10 INFO - Return code: 0 11:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:10 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')]} 11:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:10 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')]} 11:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:10 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:51:10 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 11:51:10 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 11:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:10 INFO - 'HOME': '/Users/cltbld', 11:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:10 INFO - 'LOGNAME': 'cltbld', 11:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:10 INFO - 'MOZ_NO_REMOTE': '1', 11:51:10 INFO - 'NO_EM_RESTART': '1', 11:51:10 INFO - 'PAGER': '/bin/cat', 11:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:10 INFO - 'PWD': '/builds/slave/test', 11:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:10 INFO - 'SHELL': '/bin/bash', 11:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:51:10 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:10 INFO - 'USER': 'cltbld', 11:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:10 INFO - 'XPC_FLAGS': '0x0', 11:51:10 INFO - 'XPC_SERVICE_NAME': '0', 11:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-YFrD3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-B_362C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-DUin2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-mHwS5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-76voE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-_T8wg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-NTacj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-ylKD7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:11 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)) 11:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:11 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-nM6N5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Z2UVDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-qK9Dy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-jBurEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-s1LwkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-RggqWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-jbUSXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-8xIs7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:12 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)) 11:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:12 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-404511-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:12 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)) 11:51:12 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)) 11:51:12 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)) 11:51:12 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)) 11:51:12 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)) 11:51:12 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)) 11:51:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:15 INFO - Downloading blessings-1.6.tar.gz 11:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:15 INFO - Installing collected packages: blessings 11:51:15 INFO - Running setup.py install for blessings 11:51:15 INFO - Successfully installed blessings 11:51:15 INFO - Cleaning up... 11:51:16 INFO - Return code: 0 11:51:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:16 INFO - Reading from file tmpfile_stdout 11:51:16 INFO - Current package versions: 11:51:16 INFO - blessings == 1.6 11:51:16 INFO - blobuploader == 1.2.4 11:51:16 INFO - docopt == 0.6.1 11:51:16 INFO - functools32 == 3.2.3-2 11:51:16 INFO - jsonschema == 2.5.1 11:51:16 INFO - manifestparser == 1.1 11:51:16 INFO - mozInstall == 1.12 11:51:16 INFO - mozcrash == 1.0 11:51:16 INFO - mozdebug == 0.1 11:51:16 INFO - mozdevice == 0.49 11:51:16 INFO - mozfile == 1.2 11:51:16 INFO - mozhttpd == 0.7 11:51:16 INFO - mozinfo == 0.9 11:51:16 INFO - mozleak == 0.1 11:51:16 INFO - mozlog == 3.4 11:51:16 INFO - moznetwork == 0.27 11:51:16 INFO - mozprocess == 0.24 11:51:16 INFO - mozprofile == 0.28 11:51:16 INFO - mozrunner == 6.13 11:51:16 INFO - mozscreenshot == 0.1 11:51:16 INFO - mozsystemmonitor == 0.3 11:51:16 INFO - moztest == 0.8 11:51:16 INFO - mozversion == 1.4 11:51:16 INFO - psutil == 3.1.1 11:51:16 INFO - requests == 1.2.3 11:51:16 INFO - wsgiref == 0.1.2 11:51:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:16 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:51:16 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 11:51:16 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 11:51:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:51:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:16 INFO - 'HOME': '/Users/cltbld', 11:51:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:16 INFO - 'LOGNAME': 'cltbld', 11:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:16 INFO - 'MOZ_NO_REMOTE': '1', 11:51:16 INFO - 'NO_EM_RESTART': '1', 11:51:16 INFO - 'PAGER': '/bin/cat', 11:51:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:16 INFO - 'PWD': '/builds/slave/test', 11:51:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:16 INFO - 'SHELL': '/bin/bash', 11:51:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:51:16 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:51:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:16 INFO - 'USER': 'cltbld', 11:51:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:17 INFO - 'XPC_FLAGS': '0x0', 11:51:17 INFO - 'XPC_SERVICE_NAME': '0', 11:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 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)) 11:51:17 INFO - Cleaning up... 11:51:17 INFO - Return code: 0 11:51:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:51:17 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')]} 11:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:17 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')]} 11:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:17 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 0x103882b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103885768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f52c9bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, '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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 11:51:17 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 11:51:17 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 11:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:17 INFO - 'HOME': '/Users/cltbld', 11:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:17 INFO - 'LOGNAME': 'cltbld', 11:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:17 INFO - 'MOZ_NO_REMOTE': '1', 11:51:17 INFO - 'NO_EM_RESTART': '1', 11:51:17 INFO - 'PAGER': '/bin/cat', 11:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:17 INFO - 'PWD': '/builds/slave/test', 11:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:17 INFO - 'SHELL': '/bin/bash', 11:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:51:17 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:17 INFO - 'USER': 'cltbld', 11:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:17 INFO - 'XPC_FLAGS': '0x0', 11:51:17 INFO - 'XPC_SERVICE_NAME': '0', 11:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:51:17 INFO - Cleaning up... 11:51:17 INFO - Return code: 0 11:51:17 INFO - Running post-action listener: _resource_record_post_action 11:51:17 INFO - Running post-action listener: _start_resource_monitoring 11:51:17 INFO - Starting resource monitoring. 11:51:17 INFO - [mozharness: 2017-01-12 19:51:17.943398Z] Finished create-virtualenv step (success) 11:51:17 INFO - [mozharness: 2017-01-12 19:51:17.944587Z] Running install step. 11:51:17 INFO - Running pre-action listener: _resource_record_pre_action 11:51:17 INFO - Running main action method: install 11:51:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:18 INFO - Reading from file tmpfile_stdout 11:51:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:18 INFO - Reading from file tmpfile_stdout 11:51:18 INFO - Output received: 11:51:18 INFO - Usage: mozinstall [options] installer 11:51:18 INFO - Options: 11:51:18 INFO - -h, --help show this help message and exit 11:51:18 INFO - -d DEST, --destination=DEST 11:51:18 INFO - Directory to install application into. [default: 11:51:18 INFO - "/builds/slave/test"] 11:51:18 INFO - --app=APP Application being installed. [default: firefox] 11:51:18 INFO - mkdir: /builds/slave/test/build/application 11:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:51:40 INFO - Reading from file tmpfile_stdout 11:51:40 INFO - Output received: 11:51:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:51:40 INFO - Running post-action listener: _resource_record_post_action 11:51:40 INFO - [mozharness: 2017-01-12 19:51:40.280339Z] Finished install step (success) 11:51:40 INFO - [mozharness: 2017-01-12 19:51:40.280515Z] Running run-tests step. 11:51:40 INFO - Running pre-action listener: _resource_record_pre_action 11:51:40 INFO - Running main action method: run_tests 11:51:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:51:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:51:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:51:40 INFO - 2017-01-12 11:51:40.295 screenresolution[2581:285042] starting screenresolution argv=screenresolution get 11:51:40 INFO - 2017-01-12 11:51:40.298 screenresolution[2581:285042] Display 0: 1600x1200x32@60 11:51:40 INFO - 2017-01-12 11:51:40.304 screenresolution[2582:285045] starting screenresolution argv=screenresolution list 11:51:40 INFO - Available Modes on Display 0 11:51:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:51:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:51:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:51:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:51:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:51:40 INFO - Intel Iris: 11:51:40 INFO - Chipset Model: Intel Iris 11:51:40 INFO - Type: GPU 11:51:40 INFO - Bus: Built-In 11:51:40 INFO - VRAM (Dynamic, Max): 1536 MB 11:51:40 INFO - Vendor: Intel (0x8086) 11:51:40 INFO - Device ID: 0x0a2e 11:51:40 INFO - Revision ID: 0x0009 11:51:40 INFO - Displays: 11:51:40 INFO - Display: 11:51:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:51:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:51:40 INFO - Display Serial Number: 1600x1200 60 11:51:40 INFO - Main Display: Yes 11:51:40 INFO - Mirror: Off 11:51:40 INFO - Online: Yes 11:51:40 INFO - Rotation: Supported 11:51:40 INFO - Return code: 0 11:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:51:40 INFO - Python 2.7.3 11:51:40 INFO - Return code: 0 11:51:40 INFO - grabbing minidump binary from tooltool 11:51: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')]} 11:51:40 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 0x103660d30>, '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 0x103587db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103655be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:51:40 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 11:51:40 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 11:51:40 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 11:51:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:51:40 INFO - Return code: 0 11:51:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:51:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:51:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:51:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:51:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--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 11:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0288 --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 11:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SyPjnvWdjH/Render', 11:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:40 INFO - 'HOME': '/Users/cltbld', 11:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:40 INFO - 'LOGNAME': 'cltbld', 11:51:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:40 INFO - 'MOZ_NO_REMOTE': '1', 11:51:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:40 INFO - 'NO_EM_RESTART': '1', 11:51:40 INFO - 'PAGER': '/bin/cat', 11:51:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:40 INFO - 'PWD': '/builds/slave/test', 11:51:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:40 INFO - 'SHELL': '/bin/bash', 11:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiaEH6aw8m/Listeners', 11:51:40 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 11:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:40 INFO - 'USER': 'cltbld', 11:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:40 INFO - 'XPC_FLAGS': '0x0', 11:51:40 INFO - 'XPC_SERVICE_NAME': '0', 11:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--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 11:51:40 INFO - mozversion application_buildid: 20170112094717 11:51:40 INFO - mozversion application_changeset: d55de1bf995f76bfbad5c1d3afdc3112710deb47 11:51:40 INFO - mozversion application_display_name: Nightly 11:51:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:51:40 INFO - mozversion application_name: Firefox 11:51:40 INFO - mozversion application_remotingname: firefox 11:51:40 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 11:51:40 INFO - mozversion application_vendor: Mozilla 11:51:40 INFO - mozversion application_version: 53.0a1 11:51:40 INFO - mozversion platform_buildid: 20170112094717 11:51:40 INFO - mozversion platform_changeset: d55de1bf995f76bfbad5c1d3afdc3112710deb47 11:51:40 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 11:51:40 INFO - mozversion platform_version: 53.0a1 11:51:40 INFO - using testdate: 1484250700 11:51:40 INFO - actual date: 1484250700 11:51:40 INFO - starting webserver on 'localhost:49654' 11:51:40 INFO - SUITE-START | Running 2 tests 11:51:40 INFO - TEST-START | dromaeo_css 11:51:40 INFO - operating with platform_type : mac_ 11:51:40 INFO - Initialising browser for dromaeo_css test... 11:51:40 INFO - TEST-INFO | started process 2592 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpmBDDjg/profile http://localhost:49654/getInfo.html) 11:51:43 INFO - PROCESS | 2592 | __metrics Screen width/height:1600/1200 11:51:43 INFO - PROCESS | 2592 | colorDepth:24 11:51:43 INFO - PROCESS | 2592 | Browser inner width/height: 1024/689 11:51:43 INFO - PROCESS | 2592 | __metrics 11:51:43 INFO - PROCESS | 2592 | 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" 11:51:43 INFO - PROCESS | 2592 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:44 INFO - TEST-INFO | 2592: exit 0 11:51:44 INFO - Browser initialized. 11:51:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:51:44 INFO - TEST-INFO | started process 2595 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpmBDDjg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:56 INFO - PROCESS | 2595 | RSS: Main: 235036672 11:51:56 INFO - PROCESS | 2595 | 11:54:58 INFO - PROCESS | 2595 | Cycle 1(1): loaded http://localhost:49654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49654/tests/dromaeo/cssquery-ext.html) 11:55:01 INFO - PROCESS | 2595 | RSS: Main: 452997120 11:55:01 INFO - PROCESS | 2595 | 11:56:44 INFO - PROCESS | 2595 | ************************* 11:56:44 INFO - PROCESS | 2595 | A coding exception was thrown and uncaught in a Task. 11:56:44 INFO - PROCESS | 2595 | 11:56:44 INFO - PROCESS | 2595 | Full message: ReferenceError: fetch is not defined 11:56:44 INFO - PROCESS | 2595 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:56:44 INFO - PROCESS | 2595 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:56:44 INFO - PROCESS | 2595 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:56:44 INFO - PROCESS | 2595 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:56:44 INFO - PROCESS | 2595 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:56:44 INFO - PROCESS | 2595 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:56:44 INFO - PROCESS | 2595 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:56:44 INFO - PROCESS | 2595 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:56:44 INFO - PROCESS | 2595 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:56:44 INFO - PROCESS | 2595 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:56:44 INFO - PROCESS | 2595 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:56:44 INFO - PROCESS | 2595 | 11:56:44 INFO - PROCESS | 2595 | ************************* 11:58:04 INFO - PROCESS | 2595 | Cycle 1(1): loaded http://localhost:49654/tests/dromaeo/cssquery-ext.html (next: http://localhost:49654/tests/dromaeo/cssquery-jquery.html) 11:58:05 INFO - PROCESS | 2595 | RSS: Main: 363560960 11:58:05 INFO - PROCESS | 2595 | 12:01:07 INFO - PROCESS | 2595 | Cycle 1(1): loaded http://localhost:49654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49654/tests/dromaeo/cssquery-mootools.html) 12:01:08 INFO - PROCESS | 2595 | RSS: Main: 335925248 12:01:08 INFO - PROCESS | 2595 | 12:04:10 INFO - PROCESS | 2595 | Cycle 1(1): loaded http://localhost:49654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49654/tests/dromaeo/cssquery-prototype.html) 12:04:11 INFO - PROCESS | 2595 | RSS: Main: 351031296 12:04:11 INFO - PROCESS | 2595 | 12:07:14 INFO - PROCESS | 2595 | Cycle 1(1): loaded http://localhost:49654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49654/tests/dromaeo/cssquery-yui.html) 12:07:15 INFO - PROCESS | 2595 | RSS: Main: 329572352 12:07:15 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | Cycle 1(1): loaded http://localhost:49654/tests/dromaeo/cssquery-yui.html (next: http://localhost:49654/tests/dromaeo/cssquery-dojo.html) 12:10:18 INFO - PROCESS | 2595 | RSS: Main: 403603456 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | __start_tp_report 12:10:18 INFO - PROCESS | 2595 | _x_x_mozilla_page_load 12:10:18 INFO - PROCESS | 2595 | _x_x_mozilla_page_load_details 12:10:18 INFO - PROCESS | 2595 | |i|pagename|runs| 12:10:18 INFO - PROCESS | 2595 | |0;dojo.html;3289.49012903;3301.141703157179;3304.950425743613;3335.2829141734524;3369.7472689548276;5502.80740174093;5553.944460555394;5575.330960284767;5600.719964001799;5651.40660230676;5575.275214222145;5611;5676.063449530822;5691.544676425887;5721.570882183832;5062.898742025157;5072.112380333427;5079.23811428285;5148.794048238066;5167.9224811627855;4714.740689262089;5177.119889618773;5221.425643179247;5240.816571420001;5270.472952704718;5064.797408103672;5086.669366491204;5189.221616757479;5211.42674305826;5243.9213411798855;5063.822766203165;5086.41506226785;5138.203578445347;5146.459621739701;5147.510986456281;5083.491650834924;5114.514121158484;5168.715720635363;5176.197689358156;5182.404023537304;5584.692841893694;5607.803726869581;5614.85962850932;5626.493615574618;5629.549636029108;6085.878282434326;6129.632222066691;6238.064290356438;6252.562320637558;6254.843628909268;6163.691815409256;6236.002239641681;6236.875262494725;6239.688015599202;6242.250929888397;5668.574856885709;5734.942650573525;5752.252207213078;5755.510781583613;5755.68343741094;6215.782447614311;6253.312135665074;6304.275008374096;6324.968375158187;6327.303996560375;6152.600080994721;6155.261368635793;6177.1969643946895;6179.62922224659;6187.597806142587;6139.754409823647;6269.843253918597;6283.622982621057;6297.653629050446;6309;6103.664298463538;6134.5092392608485;6143.372006418303;6154.1999540059505;6161.322254551996;6190.876182476415;6234.875302494015;6247.187865577536;6256.687165641791;6260.092286618415;4948.233023881304;4957.058158949788;4957.851264462072;4960.826371077067;4990.17662085759;4316.568343165658;4331.285337919208;4347.000189956328;4446.3330500424545;4463.509014008457;5677.971610142005;5684.715764211773;5705.286839145107;5772.653640781483;5802.680852553066;6279.0895320178315;6283.842903927439;6286.874262514724;6297.842553936188;6311.589746666452;5681.772729090872;5702.6863522506665;5717.685527296038;5740.024195886709;5780.797672081457;4889.899772551147;5058.544730974157;5336.973315133399;5350.705711185844;5428.212909128154;6252.249730032425;6295.276043254993;6300.2754683212015;6321.051842223703;6323.525735569942;6186.0102383618405;6275.121482992476;6278.152449419453;6279.372062793684;6291.150694656346;6195.876082478415;6252.656103914328;6313.55805093639;6320.747170113328;6326.114343991937;6109.7387008107025;6137.723802428991;6139.706800529493;6194.5973511721595;6223.688815559113;6276.089966954857;6278.434940855345;6279.340669229665;6292.4651404629285;6293.937060629335;6021.096835474714;6062.848428789139;6078.878422431439;6089.817305480843;6095.116208149882;5902.173695682522;5949.167116603592;6049.576529642883;6055.3944605540855;6091;5822.912656310074;5964.194833697396;5968.820935371946;5985.012472941916;6003.039513677791;5903.763849446146;5956.076808094752;5979.133025711334;5985.191999080069;6134.723937422916;5816.069428891357;5873.4126587340925;5881.911771323348;5883.441073098049;5886.293644762656 12:10:18 INFO - PROCESS | 2595 | |1;ext.html;419.6810424077701;446.8994476242844;493.8666560028792;498.8453579390387;531.8218396837058;37394.8130259349;41210.17579648405;41334.17331653369;41409.58590414095;43587.564124358745;42415.3637695434;42865.7856710716;42900.3564946526;42940;42989.261932852074;8391.11893251209;9274.02622724616;9440.244780417584;9454.069238536042;9483.857742133874;8406.537640429773;11164.274322169033;11386;11390.601328953488;11553.826692599576;11348;11375.601853935073;11392.316461012366;11408.087353011739;11416.486258118404;8381.580920953927;8578.227959483615;11328.773424531504;11376.658700239006;11414;10913.945430272877;11217.943910280477;11243.60647377338;11384.772304553862;11399;35474.64525354765;39991.80004099961;40242;40254;40312.39531407031;3612.8916132516065;4016.096378314856;4023.2556976959063;4078.8368465261356;4177;25148.622770658272;27860;32422.189445263823;32725.672743272502;33093.83453082719;3136.0905337452114;3304.8347582621013;3324;3348.564686590752;3354.1446931032674;486171;489085;495234;496236;497921;69512;70914.64542677253;71028;71111.2888871115;71171.64414177896;48402.75798620984;59873;60168;60168.09747853786;60240;16678.58303542421;16903.98576085439;16924.57688557796;16932.915335423244;16947.491575252763;11654.242474239147;11896.702582435508;12654.620361389174;12762.936185319015;12913.677158071123;17473.47579572615;17504.076481494027;21049.158033678483;21416.250431234832;21524;7996.72011479607;8615.793788869563;9095.909040909506;9151.496667683341;9241.584128714225;891.6700820696254;898.9775255618531;907.3285768531372;926.3145272498438;938.0713094036854;28730.712692872803;29923.551146732818;30315.393692126036;30508.847455762578;30630;1074.8710154781477;1076.5370890517154;1112.866456025282;1118.2116607791488;1147.7933971884975;12585.622431327074;13009.739805203842;15536.92231538835;15707.371705131894;15964;451469;619401.5448841265;622818.7718122852;624971;625217;59961.10058349128;60563.48591285165;60618.696906515186;60695.69652151711;60831.179478975304;1302.5571305756089;1435.8564143585559;1486.970260594782;1492.3955797901867;1502.676924461246;27833.72166278311;29430.852845735633;29433.96981105651;30100.698993010665;30130.69869301279;49402.81270466693;49794.502054978984;49821.252681210535;49992.00015999587;50108;509607;509793;511254;512394;512652;35181.29637407186;38765.806170968965;41909.371359430246;42700.359494606986;43221;42318.15363692647;42654.36018459788;44113.558864412225;47247.76376118098;47547;34725.652743472245;35414.64585354114;35418.29163416769;36888.26223475569;36906.077348066516;35393.11517211987;35439.46840797442;36134;36540.45189322109;36878.078048049014;31737.523937141425;35024.94925152249;35449.645503544634;35896.4615530762;36081.639183607826;29596.408071838872;31164.53253201249;32106.51840222352;32413.18967025843;32809.50785738263;20949.476263093544;23632.17287394933;23938.04247830137;24406;24455.633165502888 12:10:18 INFO - PROCESS | 2595 | |2;jquery.html;369.3259800863425;389.6609949344069;389.7252437031893;399.77812314165647;426.3242760225043;13006.54477093302;14779.334929928153;18049.4585162445;21044.579108417824;21117.57764844706;21729.78270217297;22488;22615.98228079736;23021.194258200965;23147;5631.436856314356;5747.540196784258;5870.589058765888;5899.764009439617;5975.910361344561;5791.21818554494;5907.438793314628;5912.231409916726;5916.349201587844;5929.169916211734;4149.564295748948;4348.869533913988;4372.191144638236;6439.967800160993;6535.934640653581;6271.184745983039;6500.642464664442;6515.869682606369;6529.869402611968;6533.967330163367;5704.087346024658;5770.16332631766;5779.248697669318;5783.334916484616;5787.50806181475;26345.604815927778;26641.600375994374;27266.727332726616;27359.905603776024;27512.724872751216;2737.8220415673118;2765.2119146043483;2780.179846945156;2801.2856721535877;2830.5895645131545;15786.21068946548;15966.121863297514;15995.92002039994;16082.356705731874;16582.25379857909;1789.168036862865;1812.28414776164;1827.5979284557377;1849.140149830322;1894.3085773692503;117491.41254293674;127147;130043.34978325048;130146;131017;11256.26834255787;11262.493187806405;11576.189666723418;11621.360825154528;11669.35818529972;12859.16415432994;14756.188409637572;14808.777868331983;14946.62633434151;15109.773353399707;7225.74709885162;8579;8844.734657960144;8995.820083598292;9023.909760902437;8672.316948847678;8742.737717868475;8780.736577902673;8961.23829474502;9011.594478248495;6023.27720673522;7339.70641174347;7353.6323183840595;7361.889571656322;7381.88927166093;1715.8627309815186;1883.51970247586;1940.262700173925;1943.523836659999;1950.9709901702354;392.2664617165861;410.5483967635577;416.79368712486905;428.6185295087375;1017.8498296924575;11528;11908.940455297668;11967.700807479883;12020.699482512833;12248.877511224951;444.2916984195762;447.9776011199427;453.53739186030066;458.17757125958985;461.8060414625798;4843.854684359475;5138.691678499227;5940.524758019435;5957.493613042853;6161;696421;715034;724831;741928;755961.2201938955;126598.36700816621;159150;160042;160096;164023;444.7376048131618;457.7985686298018;459.972401655895;460.7189614335253;460.86404510669433;10494.895051049392;11169.553217871518;11620.244684095507;11934.4032798358;11936;45958.31062534131;56452.30643080714;57704;59113;61603.379746518294;56736;83291.58354208432;83453.48918597355;84158;85491;5713.228714123707;8148.429609927248;8319.792005199677;8454.492730436194;8708.259797917248;9008.819823603622;11946.104042196695;12965.15726477776;13038.348082596021;13432.39554220082;11273;11360.863913608573;11673.533058677558;11895.76208475843;11972.700682483008;10821.56713731442;11279.548818047186;11443.25618834773;11654.125940554322;11723.531058757895;11432;11522.596709115476;11840.230385024946;11860.94069529647;11909.285442873455;8171.182881711781;8220.671173153007;8391.244787968868;8436.240738333334;8544.01743799471;8133.389995750224;9679.419234845931;11058.004779569877;11261.66215013551;11668.591599293984 12:10:18 INFO - PROCESS | 2595 | |3;mootools.html;1471.4040813470535;1471.8013068235784;1473.9410423583058;1486.843881392453;1491.828439729431;7514.66184021719;7797.103333116694;8171.346292296616;8599.828003439936;8622.9652441707;7735.342495887842;8138.267555919966;8402.285805706508;8418.158184181579;8515.105913879046;2319.5476882008056;2325.221050947926;2354.8469349492316;2361.3742358274985;2365.9053637854463;2263.0721404224273;2362.8818559072065;2368.3960590049514;2375.67928329675;2381.833271670984;2059.104289634014;2139.6255655260343;2140.1332460353506;2211.281333566589;2316.3051084674617;2292.32376448948;2347.847389919667;2353.3528279723214;2355.9869256219818;2356.1164563288767;2284.8400611957168;2370.182287110944;2372.2883135059587;2381.1070848431837;2381.868997205153;8289.958550207271;8374.958125209396;8380.958095209546;8383.874241886377;8401;5085.389753229599;5169.302144210521;5193.870153246199;5259.421463638997;5271.657342272779;3132.530120481923;3220.565223694818;3335.366280406715;3400.727941764678;3404;1123.7864805686975;1136.8294755786699;1161.4599211366672;1177.6231605886119;1179.2334982261598;10421.68734937953;10519.368837869675;10636.57453701851;10658.200634952409;10665.413402262873;3810.5236845394325;4386.64906807461;4480.641548676098;4524.16302983949;4707.105649926503;9466.148046675833;9471.868829513442;9478.57346419399;9483.525823708787;9489;4653.348531205634;5063.696178229318;5229.607779416559;5237.8428647140645;5241.816536421207;4590.632749380042;4661.487236403993;4727.976360118246;4735;4768.57082862544;3840.0591854995705;3853.460515527828;3917.2557214129793;3932.390479475686;3939.3106206413763;1263.5767018049057;1283.1210620724646;1288.62629837348;1304.8303720516271;1306.431702209542;751.8345963888046;783.647358688581;791.9485233459807;794.8489786940463;816.1960468938091;4534.229181039232;5418.295621569171;5590.692511911884;5612;5614.438556144434;531.5136649965316;544.0723566319416;567.2115759094861;568.5082403720752;715.8031541326072;3389.6271410144864;3469.913252168716;3508.8596456141468;3770.0951771574623;3804.9429258561145;9328;9887.851682224773;9894.010598940049;9895.257855660855;9907.058829411195;9580.808383832284;9859.50702464874;9862.01379862008;9863.704088877344;9866.30935834499;7542.6605802739;7671.769846904602;7793.10379306387;7803.180666029985;7837.9216207838335;4035.8183881724804;5303.946960530346;5406.540444062299;5429.131338985743;5520.751566179451;8909.73270801877;8913.37606367548;8988.685396011108;9113.225375842863;9202.861957070783;9047.909520904706;9191.586378612845;9276.16514513697;9313.860292095489;9320.72037838866;6905.620190889348;6954.165500140016;7010.754623588354;7065.682044307916;7084.433245340258;7665.88501172494;7737;7743;7745.109312429143;7749.883751743616;6661.833454163685;6979.476539259677;7059.929400705927;7078.079849619517;7098.609576473344;6960.408365289007;6976.19773726028;7016.333448322402;7018.613976231356;7050.5769653820935;6232.688365581612;6258.874822503615;6358.650274234961;6359.268684101387;6361.681915904279;4884.731339776205;4927.901441971068;4948.6535942485125;4967.850964471072;5048.646594738333;4852.490488498657;4896.92654610174;4965.255211718271;5038.899222015466;5105.821296254613 12:10:18 INFO - PROCESS | 2595 | |4;prototype.html;344.5864962045546;350.3850741947881;363.60185596771527;373.27211936723364;374.7227051981533;4614.630829533633;4903.6322275829325;4965.726885021322;5154.613403994701;5242.239875218091;4257.6806739494505;5093.71984540851;5098.337216161903;5134.691918484884;5148.69107853529;3361.9495707564406;3761.849526018956;3901.6293452122004;3963.326234540135;3973.940390894139;3492.807895565743;3694.8152592370407;4004.259212045766;4056.290149223889;4074.8981275468204;3314.519394687769;3411.0790086676584;3538.610752817188;4038.4144299076615;4048;3549.3078849624335;3888.3972984187494;4065.7763822989723;4084.2035803018425;4084.611961863618;3085.1207405889213;3555.2000799820094;3604.5849280981806;3655;3670.467782171597;4391.538888416734;5032.345795046657;5045.823396181116;5063.8480845574695;5093.923591146136;3947.684185265172;4664.930026049612;4726.0784147091335;4732.290156476522;4733.982193828343;4652.162610730067;4771.928421073687;4780.613622049602;4805.678438429425;5587.944120558824;3503.915170473564;3582.4268117101137;4049.3318602430563;4052.5339585947404;4060.5739743679533;4683.812647494096;4727.3854398927915;5227.268182454497;5495.917561236584;5694.9430505695245;3534.3638145134123;3614.692751116132;4138.317177665712;4146.481689788777;4151.723724563704;4227.281362168377;4227.598378154071;4240.809163587646;4247.3628955656895;4252.744835309892;4206.348016057516;4516.412866327357;4739.526047395233;4754.381930349033;4778.904421911542;4897.902041959141;5524.392316845144;5570.220169176318;5575.637583557056;5608.747606357723;1191;1225.4607972492074;1239.4670291774623;1314.0998416085013;1381.4198036824557;784;833.3125171733224;909.7218408136579;917.8118485710413;921.6681994481982;3998.4402183694306;4076.775777332216;4866.416030076342;4872.805087796449;4874.488178741181;5108.693478391308;5326.174442961347;5335.733213339317;5396.541293990055;5411.56707463402;4181.937270940938;4607.401037865056;4873.00103478786;4913.582345500672;4965.950340496621;2421.413973847133;2424.709034915786;2604;2654.9867250663624;2852.7432531072304;4867.683600565952;4946.5407704727195;5396.703181325065;5403.513683768401;5551.777928882881;4577.8397756078375;4781.876259079114;4902.191138462185;5249.448807875118;5319.760610772524;4927.408710954636;5861.6189947653265;5871.119332100134;5910.547122944016;5912.970435147797;5395.70323632204;5682.352117885767;5696.6897613549945;5706.4864162225595;5730.5129064030025;4458.799354029012;4717.532613529122;4922.483139270325;5112.667676601009;5622.931642987819;5375.704336261387;5492.47821456961;5593.272874526286;5688.232088667977;5852.239208902815;3699.7595156314756;3799.7340186186702;3818.503594532693;3823.2353529293696;3826.0626146594263;5365.65123267002;5695.288088988877;5701.572382071278;5704.3154821421695;5728.427157284238;4981.2030075187795;5103.668261562986;5298.28473156119;5484.753186106715;5543.861403464945;5469.617126801086;5484.643498172606;5504.394516603091;5523.337199536081;5532.557395408277;4712.293156026623;4885.876248462802;4900.94629654626;5004.721907150822;5387.865303367447;5433.9675461662155;5446.509814116748;5501.697406642673;5511.834644960658;5546.94608024474;5308.495692909168;5350.545203657733;5381.381141168816;5412.891742165213;5455.863603409946 12:10:18 INFO - PROCESS | 2595 | |5;yui.html;703.6727921516496;733.8862476316169;766.4328396986232;803.0764620686211;828.3745771942183;15261;15524.611884702888;15922.203889805493;15940.920295398506;15963.68072638548;14290.356933937972;14301.570952871405;14335.92832035841;14697.412103515846;14819.333130009149;673.636236432326;692.7609974558769;698.5040621158984;833.3957880536593;853.9274161696247;854.598338780772;863.1713554987219;873.9475631462133;876.3865294293988;876.701921346742;928.7956649537125;929.0152438415267;929.739672891588;929.8512238041915;931.4969916245219;707.5294928872294;730.620077559666;921.7280902133887;923.5613083785215;925.7593025813337;663.7212370804225;683.8666460040295;689.4794430205213;690.3476214976849;692.536000879412;15266.236688165658;15439.305231264509;15558.688826223412;15619.609509762233;15623.765643515357;13943.72487717727;14012.789808152886;14031.929840350733;14138.08102473336;14238.857611423857;12655.367231638382;12761.61715148547;12825.102242843004;13043.347832608426;13115.737685246337;4357.9564204358185;4419.160359531678;4442.355858400546;4444.31113177458;4459.554044595547;103663;105718.47140764324;107418.77743667703;107656;110922.9999999992;10701.411422371844;10781.62264320745;10969.670909872557;11079.612213572485;11404.258723182966;21948.34154975353;22370.210383169306;22370.55258894813;22396.216132435286;22405.87970601496;7496.7001319947685;7583;7624.27569380908;7872.881906771403;7946.920530794618;4192.4759405074365;4249.80875860587;4272.060146767706;4282.443282373271;4420.270655341833;3418.67522585354;3427.365937301607;3465.9480107798404;3487.1805125795418;3507.4212754895157;630.6941133550224;635.3170341882402;638.6902352359102;648.3872740260408;648.8734696734092;489.9906193241933;638.5051585021553;643.8680070585518;661.0612929639826;665.7769647168157;9239.168474837297;9707.223422126213;9742.31803773729;9774.804503910023;9784.510774461249;532.1432493685164;650.4698670583459;652.774792696519;661.1174082599783;663.6781161136845;4581.5918363275205;4654.371659825948;4659.534046595381;4681.531846815359;4762.690425122356;103971.96028039623;106203;106981.93018069719;107576;108288;93083.53458232665;95046;95184.52407737917;95505.08989820303;97230.51384743031;83513.74729379185;84371.7344239837;85846.57076714702;85890.57054714937;86826.56586717025;8318.334533237448;8780.639000954861;8817.16236957488;8826.602802874015;8890.288776897962;53282.73358633182;53911.73044134754;55672.44327556673;55991.72004140116;57070.7146464265;68132;71374.28625713884;72263.91604125837;73669;74563;11571.132165087483;11581.88418115808;11791.351475668578;12035.157538972539;12210.450529726362;12000.939995299968;12058.698532536757;12074.758504829679;12186.268823870596;12628.305443200345;11559.942200288944;11565.421728913352;11674.182807203753;11817.409129543661;12076.094292928241;11861.229020113666;11912.463939122586;11919.225250358699;11966.880331196577;12087.274763514217;9535.189508891823;11642;11644.35956022393;11697.941510292734;11760.294382337088;9719.682206565789;9735.367201131903;9846.950765246127;9958.15355694774;10152.441615710912;9735.41587504752;9837.409755414697;9842.852357214791;9849.704508864745;10158.441285729356 12:10:18 INFO - PROCESS | 2595 | __end_tp_report 12:10:18 INFO - PROCESS | 2595 | __start_cc_report 12:10:18 INFO - PROCESS | 2595 | _x_x_mozilla_cycle_collect,2573 12:10:18 INFO - PROCESS | 2595 | __end_cc_report 12:10:18 INFO - PROCESS | 2595 | __startTimestamp1484251818550__endTimestamp 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | ------- Summary: start ------- 12:10:18 INFO - PROCESS | 2595 | Number of tests: 6 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | [#0] dojo.html Cycles:165 Average:5713.20 Median:5903.76 stddev:657.42 (11.1%) stddev-sans-first:631.34 12:10:18 INFO - PROCESS | 2595 | Values: 3289.5 3301.1 3305.0 3335.3 3369.7 5502.8 5553.9 5575.3 5600.7 5651.4 5575.3 5611.0 5676.1 5691.5 5721.6 5062.9 5072.1 5079.2 5148.8 5167.9 4714.7 5177.1 5221.4 5240.8 5270.5 5064.8 5086.7 5189.2 5211.4 5243.9 5063.8 5086.4 5138.2 5146.5 5147.5 5083.5 5114.5 5168.7 5176.2 5182.4 5584.7 5607.8 5614.9 5626.5 5629.5 6085.9 6129.6 6238.1 6252.6 6254.8 6163.7 6236.0 6236.9 6239.7 6242.3 5668.6 5734.9 5752.3 5755.5 5755.7 6215.8 6253.3 6304.3 6325.0 6327.3 6152.6 6155.3 6177.2 6179.6 6187.6 6139.8 6269.8 6283.6 6297.7 6309.0 6103.7 6134.5 6143.4 6154.2 6161.3 6190.9 6234.9 6247.2 6256.7 6260.1 4948.2 4957.1 4957.9 4960.8 4990.2 4316.6 4331.3 4347.0 4446.3 4463.5 5678.0 5684.7 5705.3 5772.7 5802.7 6279.1 6283.8 6286.9 6297.8 6311.6 5681.8 5702.7 5717.7 5740.0 5780.8 4889.9 5058.5 5337.0 5350.7 5428.2 6252.2 6295.3 6300.3 6321.1 6323.5 6186.0 6275.1 6278.2 6279.4 6291.2 6195.9 6252.7 6313.6 6320.7 6326.1 6109.7 6137.7 6139.7 6194.6 6223.7 6276.1 6278.4 6279.3 6292.5 6293.9 6021.1 6062.8 6078.9 6089.8 6095.1 5902.2 5949.2 6049.6 6055.4 6091.0 5822.9 5964.2 5968.8 5985.0 6003.0 5903.8 5956.1 5979.1 5985.2 6134.7 5816.1 5873.4 5881.9 5883.4 5886.3 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | [#1] ext.html Cycles:180 Average:67442.32 Median:36337.23 stddev:142296.50 (391.6%) stddev-sans-first:142606.70 12:10:18 INFO - PROCESS | 2595 | Values: 419.7 446.9 493.9 498.8 531.8 37394.8 41210.2 41334.2 41409.6 43587.6 42415.4 42865.8 42900.4 42940.0 42989.3 8391.1 9274.0 9440.2 9454.1 9483.9 8406.5 11164.3 11386.0 11390.6 11553.8 11348.0 11375.6 11392.3 11408.1 11416.5 8381.6 8578.2 11328.8 11376.7 11414.0 10913.9 11217.9 11243.6 11384.8 11399.0 35474.6 39991.8 40242.0 40254.0 40312.4 3612.9 4016.1 4023.3 4078.8 4177.0 25148.6 27860.0 32422.2 32725.7 33093.8 3136.1 3304.8 3324.0 3348.6 3354.1 486171.0 489085.0 495234.0 496236.0 497921.0 69512.0 70914.6 71028.0 71111.3 71171.6 48402.8 59873.0 60168.0 60168.1 60240.0 16678.6 16904.0 16924.6 16932.9 16947.5 11654.2 11896.7 12654.6 12762.9 12913.7 17473.5 17504.1 21049.2 21416.3 21524.0 7996.7 8615.8 9095.9 9151.5 9241.6 891.7 899.0 907.3 926.3 938.1 28730.7 29923.6 30315.4 30508.8 30630.0 1074.9 1076.5 1112.9 1118.2 1147.8 12585.6 13009.7 15536.9 15707.4 15964.0 451469.0 619401.5 622818.8 624971.0 625217.0 59961.1 60563.5 60618.7 60695.7 60831.2 1302.6 1435.9 1487.0 1492.4 1502.7 27833.7 29430.9 29434.0 30100.7 30130.7 49402.8 49794.5 49821.3 49992.0 50108.0 509607.0 509793.0 511254.0 512394.0 512652.0 35181.3 38765.8 41909.4 42700.4 43221.0 42318.2 42654.4 44113.6 47247.8 47547.0 34725.7 35414.6 35418.3 36888.3 36906.1 35393.1 35439.5 36134.0 36540.5 36878.1 31737.5 35024.9 35449.6 35896.5 36081.6 29596.4 31164.5 32106.5 32413.2 32809.5 20949.5 23632.2 23938.0 24406.0 24455.6 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | [#2] jquery.html Cycles:180 Average:39343.02 Median:391.00 stddev:121239.98 (31008.0%) stddev-sans-first:121544.77 12:10:18 INFO - PROCESS | 2595 | Values: 369.3 389.7 389.7 399.8 426.3 13006.5 14779.3 18049.5 21044.6 21117.6 21729.8 22488.0 22616.0 23021.2 23147.0 5631.4 5747.5 5870.6 5899.8 5975.9 5791.2 5907.4 5912.2 5916.3 5929.2 4149.6 4348.9 4372.2 6440.0 6535.9 6271.2 6500.6 6515.9 6529.9 6534.0 5704.1 5770.2 5779.2 5783.3 5787.5 26345.6 26641.6 27266.7 27359.9 27512.7 2737.8 2765.2 2780.2 2801.3 2830.6 15786.2 15966.1 15995.9 16082.4 16582.3 1789.2 1812.3 1827.6 1849.1 1894.3 117491.4 127147.0 130043.3 130146.0 131017.0 11256.3 11262.5 11576.2 11621.4 11669.4 12859.2 14756.2 14808.8 14946.6 15109.8 7225.7 8579.0 8844.7 8995.8 9023.9 8672.3 8742.7 8780.7 8961.2 9011.6 6023.3 7339.7 7353.6 7361.9 7381.9 1715.9 1883.5 1940.3 1943.5 1951.0 392.3 410.5 416.8 428.6 1017.8 11528.0 11908.9 11967.7 12020.7 12248.9 444.3 448.0 453.5 458.2 461.8 4843.9 5138.7 5940.5 5957.5 6161.0 696421.0 715034.0 724831.0 741928.0 755961.2 126598.4 159150.0 160042.0 160096.0 164023.0 444.7 457.8 460.0 460.7 460.9 10494.9 11169.6 11620.2 11934.4 11936.0 45958.3 56452.3 57704.0 59113.0 61603.4 56736.0 83291.6 83453.5 84158.0 85491.0 5713.2 8148.4 8319.8 8454.5 8708.3 9008.8 11946.1 12965.2 13038.3 13432.4 11273.0 11360.9 11673.5 11895.8 11972.7 10821.6 11279.5 11443.3 11654.1 11723.5 11432.0 11522.6 11840.2 11860.9 11909.3 8171.2 8220.7 8391.2 8436.2 8544.0 8133.4 9679.4 11058.0 11261.7 11668.6 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | [#3] mootools.html Cycles:180 Average:5356.61 Median:5265.54 stddev:2938.51 (55.8%) stddev-sans-first:2932.24 12:10:18 INFO - PROCESS | 2595 | Values: 1471.4 1471.8 1473.9 1486.8 1491.8 7514.7 7797.1 8171.3 8599.8 8623.0 7735.3 8138.3 8402.3 8418.2 8515.1 2319.5 2325.2 2354.8 2361.4 2365.9 2263.1 2362.9 2368.4 2375.7 2381.8 2059.1 2139.6 2140.1 2211.3 2316.3 2292.3 2347.8 2353.4 2356.0 2356.1 2284.8 2370.2 2372.3 2381.1 2381.9 8290.0 8375.0 8381.0 8383.9 8401.0 5085.4 5169.3 5193.9 5259.4 5271.7 3132.5 3220.6 3335.4 3400.7 3404.0 1123.8 1136.8 1161.5 1177.6 1179.2 10421.7 10519.4 10636.6 10658.2 10665.4 3810.5 4386.6 4480.6 4524.2 4707.1 9466.1 9471.9 9478.6 9483.5 9489.0 4653.3 5063.7 5229.6 5237.8 5241.8 4590.6 4661.5 4728.0 4735.0 4768.6 3840.1 3853.5 3917.3 3932.4 3939.3 1263.6 1283.1 1288.6 1304.8 1306.4 751.8 783.6 791.9 794.8 816.2 4534.2 5418.3 5590.7 5612.0 5614.4 531.5 544.1 567.2 568.5 715.8 3389.6 3469.9 3508.9 3770.1 3804.9 9328.0 9887.9 9894.0 9895.3 9907.1 9580.8 9859.5 9862.0 9863.7 9866.3 7542.7 7671.8 7793.1 7803.2 7837.9 4035.8 5303.9 5406.5 5429.1 5520.8 8909.7 8913.4 8988.7 9113.2 9202.9 9047.9 9191.6 9276.2 9313.9 9320.7 6905.6 6954.2 7010.8 7065.7 7084.4 7665.9 7737.0 7743.0 7745.1 7749.9 6661.8 6979.5 7059.9 7078.1 7098.6 6960.4 6976.2 7016.3 7018.6 7050.6 6232.7 6258.9 6358.7 6359.3 6361.7 4884.7 4927.9 4948.7 4967.9 5048.6 4852.5 4896.9 4965.3 5038.9 5105.8 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | [#4] prototype.html Cycles:180 Average:4392.82 Median:4872.90 stddev:1325.38 (27.2%) stddev-sans-first:1293.80 12:10:18 INFO - PROCESS | 2595 | Values: 344.6 350.4 363.6 373.3 374.7 4614.6 4903.6 4965.7 5154.6 5242.2 4257.7 5093.7 5098.3 5134.7 5148.7 3361.9 3761.8 3901.6 3963.3 3973.9 3492.8 3694.8 4004.3 4056.3 4074.9 3314.5 3411.1 3538.6 4038.4 4048.0 3549.3 3888.4 4065.8 4084.2 4084.6 3085.1 3555.2 3604.6 3655.0 3670.5 4391.5 5032.3 5045.8 5063.8 5093.9 3947.7 4664.9 4726.1 4732.3 4734.0 4652.2 4771.9 4780.6 4805.7 5587.9 3503.9 3582.4 4049.3 4052.5 4060.6 4683.8 4727.4 5227.3 5495.9 5694.9 3534.4 3614.7 4138.3 4146.5 4151.7 4227.3 4227.6 4240.8 4247.4 4252.7 4206.3 4516.4 4739.5 4754.4 4778.9 4897.9 5524.4 5570.2 5575.6 5608.7 1191.0 1225.5 1239.5 1314.1 1381.4 784.0 833.3 909.7 917.8 921.7 3998.4 4076.8 4866.4 4872.8 4874.5 5108.7 5326.2 5335.7 5396.5 5411.6 4181.9 4607.4 4873.0 4913.6 4966.0 2421.4 2424.7 2604.0 2655.0 2852.7 4867.7 4946.5 5396.7 5403.5 5551.8 4577.8 4781.9 4902.2 5249.4 5319.8 4927.4 5861.6 5871.1 5910.5 5913.0 5395.7 5682.4 5696.7 5706.5 5730.5 4458.8 4717.5 4922.5 5112.7 5622.9 5375.7 5492.5 5593.3 5688.2 5852.2 3699.8 3799.7 3818.5 3823.2 3826.1 5365.7 5695.3 5701.6 5704.3 5728.4 4981.2 5103.7 5298.3 5484.8 5543.9 5469.6 5484.6 5504.4 5523.3 5532.6 4712.3 4885.9 4900.9 5004.7 5387.9 5434.0 5446.5 5501.7 5511.8 5546.9 5308.5 5350.5 5381.4 5412.9 5455.9 12:10:18 INFO - PROCESS | 2595 | 12:10:18 INFO - PROCESS | 2595 | [#5] yui.html Cycles:180 Average:20991.93 Median:2626.34 stddev:31011.91 (1180.8%) stddev-sans-first:31061.49 12:10:18 INFO - PROCESS | 2595 | Values: 703.7 733.9 766.4 803.1 828.4 15261.0 15524.6 15922.2 15940.9 15963.7 14290.4 14301.6 14335.9 14697.4 14819.3 673.6 692.8 698.5 833.4 853.9 854.6 863.2 873.9 876.4 876.7 928.8 929.0 929.7 929.9 931.5 707.5 730.6 921.7 923.6 925.8 663.7 683.9 689.5 690.3 692.5 15266.2 15439.3 15558.7 15619.6 15623.8 13943.7 14012.8 14031.9 14138.1 14238.9 12655.4 12761.6 12825.1 13043.3 13115.7 4358.0 4419.2 4442.4 4444.3 4459.6 103663.0 105718.5 107418.8 107656.0 110923.0 10701.4 10781.6 10969.7 11079.6 11404.3 21948.3 22370.2 22370.6 22396.2 22405.9 7496.7 7583.0 7624.3 7872.9 7946.9 4192.5 4249.8 4272.1 4282.4 4420.3 3418.7 3427.4 3465.9 3487.2 3507.4 630.7 635.3 638.7 648.4 648.9 490.0 638.5 643.9 661.1 665.8 9239.2 9707.2 9742.3 9774.8 9784.5 532.1 650.5 652.8 661.1 663.7 4581.6 4654.4 4659.5 4681.5 4762.7 103972.0 106203.0 106981.9 107576.0 108288.0 93083.5 95046.0 95184.5 95505.1 97230.5 83513.7 84371.7 85846.6 85890.6 86826.6 8318.3 8780.6 8817.2 8826.6 8890.3 53282.7 53911.7 55672.4 55991.7 57070.7 68132.0 71374.3 72263.9 73669.0 74563.0 11571.1 11581.9 11791.4 12035.2 12210.5 12000.9 12058.7 12074.8 12186.3 12628.3 11559.9 11565.4 11674.2 11817.4 12076.1 11861.2 11912.5 11919.2 11966.9 12087.3 9535.2 11642.0 11644.4 11697.9 11760.3 9719.7 9735.4 9847.0 9958.2 10152.4 9735.4 9837.4 9842.9 9849.7 10158.4 12:10:18 INFO - PROCESS | 2595 | -------- Summary: end -------- 12:10:18 INFO - PROCESS | 2595 | 12:10:19 INFO - TEST-INFO | 2595: exit 0 12:10:19 INFO - TEST-OK | dromaeo_css | took 1118353ms 12:10:19 INFO - TEST-START | kraken 12:10:19 INFO - operating with platform_type : mac_ 12:10:19 INFO - Initialising browser for kraken test... 12:10:19 INFO - TEST-INFO | started process 2599 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmp0u_AhH/profile http://localhost:49654/getInfo.html) 12:10:21 INFO - PROCESS | 2599 | __metrics Screen width/height:1600/1200 12:10:21 INFO - PROCESS | 2599 | colorDepth:24 12:10:21 INFO - PROCESS | 2599 | Browser inner width/height: 1024/689 12:10:21 INFO - PROCESS | 2599 | __metrics 12:10:21 INFO - PROCESS | 2599 | 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" 12:10:21 INFO - PROCESS | 2599 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:10:22 INFO - TEST-INFO | 2599: exit 0 12:10:22 INFO - Browser initialized. 12:10:22 INFO - Running cycle 1/1 for kraken test... 12:10:22 INFO - TEST-INFO | started process 2600 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmp0u_AhH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:34 INFO - PROCESS | 2600 | RSS: Main: 234377216 12:10:34 INFO - PROCESS | 2600 | 12:10:37 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49654/tests/kraken/driver.html?testName=audio-beat-detection) 12:10:38 INFO - PROCESS | 2600 | RSS: Main: 288063488 12:10:38 INFO - PROCESS | 2600 | 12:10:40 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49654/tests/kraken/driver.html?testName=audio-dft) 12:10:41 INFO - PROCESS | 2600 | RSS: Main: 289415168 12:10:41 INFO - PROCESS | 2600 | 12:10:44 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49654/tests/kraken/driver.html?testName=audio-fft) 12:10:45 INFO - PROCESS | 2600 | RSS: Main: 379412480 12:10:45 INFO - PROCESS | 2600 | 12:10:47 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49654/tests/kraken/driver.html?testName=audio-oscillator) 12:10:47 INFO - PROCESS | 2600 | RSS: Main: 283369472 12:10:47 INFO - PROCESS | 2600 | 12:10:49 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:10:50 INFO - PROCESS | 2600 | RSS: Main: 286740480 12:10:50 INFO - PROCESS | 2600 | 12:10:53 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49654/tests/kraken/driver.html?testName=imaging-darkroom) 12:10:53 INFO - PROCESS | 2600 | RSS: Main: 329973760 12:10:53 INFO - PROCESS | 2600 | 12:10:56 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49654/tests/kraken/driver.html?testName=imaging-desaturate) 12:10:57 INFO - PROCESS | 2600 | RSS: Main: 330981376 12:10:57 INFO - PROCESS | 2600 | 12:11:00 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49654/tests/kraken/driver.html?testName=json-parse-financial) 12:11:00 INFO - PROCESS | 2600 | RSS: Main: 328495104 12:11:00 INFO - PROCESS | 2600 | 12:11:02 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:11:02 INFO - PROCESS | 2600 | RSS: Main: 305098752 12:11:02 INFO - PROCESS | 2600 | 12:11:04 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:05 INFO - PROCESS | 2600 | RSS: Main: 306675712 12:11:05 INFO - PROCESS | 2600 | 12:11:07 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:08 INFO - PROCESS | 2600 | RSS: Main: 308297728 12:11:08 INFO - PROCESS | 2600 | 12:11:11 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:12 INFO - PROCESS | 2600 | RSS: Main: 322072576 12:11:12 INFO - PROCESS | 2600 | 12:11:15 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:15 INFO - PROCESS | 2600 | RSS: Main: 320299008 12:11:15 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:49654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49654/tests/kraken/driver.html?testName=ai-astar) 12:11:17 INFO - PROCESS | 2600 | RSS: Main: 364548096 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | __start_tp_report 12:11:17 INFO - PROCESS | 2600 | _x_x_mozilla_page_load 12:11:17 INFO - PROCESS | 2600 | _x_x_mozilla_page_load_details 12:11:17 INFO - PROCESS | 2600 | |i|pagename|runs| 12:11:17 INFO - PROCESS | 2600 | |0;ai-astar;114;114;115;114;114;115;112;113;113;114 12:11:17 INFO - PROCESS | 2600 | |1;audio-beat-detection;141;113;132;179;114;110;109;109;128;111 12:11:17 INFO - PROCESS | 2600 | |2;audio-dft;186;187;184;184;183;184;183;182;183;187 12:11:17 INFO - PROCESS | 2600 | |3;audio-fft;82;58;59;90;65;61;59;58;74;59 12:11:17 INFO - PROCESS | 2600 | |4;audio-oscillator;86;72;86;69;69;68;83;70;69;85 12:11:17 INFO - PROCESS | 2600 | |5;imaging-gaussian-blur;88;85;88;85;88;84;89;86;89;84 12:11:17 INFO - PROCESS | 2600 | |6;imaging-darkroom;92;94;93;94;94;93;94;94;94;93 12:11:17 INFO - PROCESS | 2600 | |7;imaging-desaturate;87;86;86;85;87;87;87;85;88;89 12:11:17 INFO - PROCESS | 2600 | |8;json-parse-financial;55;56;53;54;55;56;53;54;55;54 12:11:17 INFO - PROCESS | 2600 | |9;json-stringify-tinderbox;71;69;75;77;73;69;71;71;70;72 12:11:17 INFO - PROCESS | 2600 | |10;stanford-crypto-aes;88;92;90;88;101;110;109;83;87;98 12:11:17 INFO - PROCESS | 2600 | |11;stanford-crypto-ccm;142;140;140;141;140;146;174;132;218;190 12:11:17 INFO - PROCESS | 2600 | |12;stanford-crypto-pbkdf2;171;173;180;173;174;164;174;174;201;238 12:11:17 INFO - PROCESS | 2600 | |13;stanford-crypto-sha256-iterative;67;69;69;69;68;69;67;66;67;66 12:11:17 INFO - PROCESS | 2600 | __end_tp_report 12:11:17 INFO - PROCESS | 2600 | __start_cc_report 12:11:17 INFO - PROCESS | 2600 | _x_x_mozilla_cycle_collect,1919 12:11:17 INFO - PROCESS | 2600 | __end_cc_report 12:11:17 INFO - PROCESS | 2600 | __startTimestamp1484251877839__endTimestamp 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | ------- Summary: start ------- 12:11:17 INFO - PROCESS | 2600 | Number of tests: 14 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 12:11:17 INFO - PROCESS | 2600 | Values: 114.0 114.0 115.0 114.0 114.0 115.0 112.0 113.0 113.0 114.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:121.00 stddev:22.18 (18.3%) stddev-sans-first:22.71 12:11:17 INFO - PROCESS | 2600 | Values: 141.0 113.0 132.0 179.0 114.0 110.0 109.0 109.0 128.0 111.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.00 stddev:1.77 (1.0%) stddev-sans-first:1.76 12:11:17 INFO - PROCESS | 2600 | Values: 186.0 187.0 184.0 184.0 183.0 184.0 183.0 182.0 183.0 187.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#3] audio-fft Cycles:10 Average:66.50 Median:63.00 stddev:11.52 (18.3%) stddev-sans-first:10.77 12:11:17 INFO - PROCESS | 2600 | Values: 82.0 58.0 59.0 90.0 65.0 61.0 59.0 58.0 74.0 59.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:77.50 stddev:8.11 (10.5%) stddev-sans-first:7.70 12:11:17 INFO - PROCESS | 2600 | Values: 86.0 72.0 86.0 69.0 69.0 68.0 83.0 70.0 69.0 85.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:2.01 (2.3%) stddev-sans-first:2.07 12:11:17 INFO - PROCESS | 2600 | Values: 88.0 85.0 88.0 85.0 88.0 84.0 89.0 86.0 89.0 84.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.71 (0.8%) stddev-sans-first:0.50 12:11:17 INFO - PROCESS | 2600 | Values: 92.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:1.25 (1.4%) stddev-sans-first:1.32 12:11:17 INFO - PROCESS | 2600 | Values: 87.0 86.0 86.0 85.0 87.0 87.0 87.0 85.0 88.0 89.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.08 (2.0%) stddev-sans-first:1.13 12:11:17 INFO - PROCESS | 2600 | Values: 55.0 56.0 53.0 54.0 55.0 56.0 53.0 54.0 55.0 54.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.50 stddev:2.57 (3.6%) stddev-sans-first:2.71 12:11:17 INFO - PROCESS | 2600 | Values: 71.0 69.0 75.0 77.0 73.0 69.0 71.0 71.0 70.0 72.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:88.00 stddev:9.45 (10.7%) stddev-sans-first:9.72 12:11:17 INFO - PROCESS | 2600 | Values: 88.0 92.0 90.0 88.0 101.0 110.0 109.0 83.0 87.0 98.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#11] stanford-crypto-ccm Cycles:10 Average:156.30 Median:144.00 stddev:28.26 (19.6%) stddev-sans-first:29.50 12:11:17 INFO - PROCESS | 2600 | Values: 142.0 140.0 140.0 141.0 140.0 146.0 174.0 132.0 218.0 190.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:174.00 stddev:21.86 (12.6%) stddev-sans-first:22.80 12:11:17 INFO - PROCESS | 2600 | Values: 171.0 173.0 180.0 173.0 174.0 164.0 174.0 174.0 201.0 238.0 12:11:17 INFO - PROCESS | 2600 | 12:11:17 INFO - PROCESS | 2600 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.30 12:11:17 INFO - PROCESS | 2600 | Values: 67.0 69.0 69.0 69.0 68.0 69.0 67.0 66.0 67.0 66.0 12:11:17 INFO - PROCESS | 2600 | -------- Summary: end -------- 12:11:17 INFO - PROCESS | 2600 | 12:11:18 INFO - TEST-INFO | 2600: exit 0 12:11:18 INFO - TEST-OK | kraken | took 59474ms 12:11:18 INFO - SUITE-END | took 1177s 12:11:18 INFO - Completed test suite (00:19:38) 12:11:18 INFO - javascript benchmark 12:11:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3289.49012903, 3301.141703157179, 3304.950425743613, 3335.2829141734524, 3369.7472689548276, 5502.80740174093, 5553.944460555394, 5575.330960284767, 5600.719964001799, 5651.40660230676, 5575.275214222145, 5611.0, 5676.063449530822, 5691.544676425887, 5721.570882183832, 5062.898742025157, 5072.112380333427, 5079.23811428285, 5148.794048238066, 5167.9224811627855, 4714.740689262089, 5177.119889618773, 5221.425643179247, 5240.816571420001, 5270.472952704718, 5064.797408103672, 5086.669366491204, 5189.221616757479, 5211.42674305826, 5243.9213411798855, 5063.822766203165, 5086.41506226785, 5138.203578445347, 5146.459621739701, 5147.510986456281, 5083.491650834924, 5114.514121158484, 5168.715720635363, 5176.197689358156, 5182.404023537304, 5584.692841893694, 5607.803726869581, 5614.85962850932, 5626.493615574618, 5629.549636029108, 6085.878282434326, 6129.632222066691, 6238.064290356438, 6252.562320637558, 6254.843628909268, 6163.691815409256, 6236.002239641681, 6236.875262494725, 6239.688015599202, 6242.250929888397, 5668.574856885709, 5734.942650573525, 5752.252207213078, 5755.510781583613, 5755.68343741094, 6215.782447614311, 6253.312135665074, 6304.275008374096, 6324.968375158187, 6327.303996560375, 6152.600080994721, 6155.261368635793, 6177.1969643946895, 6179.62922224659, 6187.597806142587, 6139.754409823647, 6269.843253918597, 6283.622982621057, 6297.653629050446, 6309.0, 6103.664298463538, 6134.5092392608485, 6143.372006418303, 6154.1999540059505, 6161.322254551996, 6190.876182476415, 6234.875302494015, 6247.187865577536, 6256.687165641791, 6260.092286618415, 4948.233023881304, 4957.058158949788, 4957.851264462072, 4960.826371077067, 4990.17662085759, 4316.568343165658, 4331.285337919208, 4347.000189956328, 4446.3330500424545, 4463.509014008457, 5677.971610142005, 5684.715764211773, 5705.286839145107, 5772.653640781483, 5802.680852553066, 6279.0895320178315, 6283.842903927439, 6286.874262514724, 6297.842553936188, 6311.589746666452, 5681.772729090872, 5702.6863522506665, 5717.685527296038, 5740.024195886709, 5780.797672081457, 4889.899772551147, 5058.544730974157, 5336.973315133399, 5350.705711185844, 5428.212909128154, 6252.249730032425, 6295.276043254993, 6300.2754683212015, 6321.051842223703, 6323.525735569942, 6186.0102383618405, 6275.121482992476, 6278.152449419453, 6279.372062793684, 6291.150694656346, 6195.876082478415, 6252.656103914328, 6313.55805093639, 6320.747170113328, 6326.114343991937, 6109.7387008107025, 6137.723802428991, 6139.706800529493, 6194.5973511721595, 6223.688815559113, 6276.089966954857, 6278.434940855345, 6279.340669229665, 6292.4651404629285, 6293.937060629335, 6021.096835474714, 6062.848428789139, 6078.878422431439, 6089.817305480843, 6095.116208149882, 5902.173695682522, 5949.167116603592, 6049.576529642883, 6055.3944605540855, 6091.0, 5822.912656310074, 5964.194833697396, 5968.820935371946, 5985.012472941916, 6003.039513677791, 5903.763849446146, 5956.076808094752, 5979.133025711334, 5985.191999080069, 6134.723937422916, 5816.069428891357, 5873.4126587340925, 5881.911771323348, 5883.441073098049, 5886.293644762656], "value": 5669.090911847924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.6810424077701, 446.8994476242844, 493.8666560028792, 498.8453579390387, 531.8218396837058, 37394.8130259349, 41210.17579648405, 41334.17331653369, 41409.58590414095, 43587.564124358745, 42415.3637695434, 42865.7856710716, 42900.3564946526, 42940.0, 42989.261932852074, 8391.11893251209, 9274.02622724616, 9440.244780417584, 9454.069238536042, 9483.857742133874, 8406.537640429773, 11164.274322169033, 11386.0, 11390.601328953488, 11553.826692599576, 11348.0, 11375.601853935073, 11392.316461012366, 11408.087353011739, 11416.486258118404, 8381.580920953927, 8578.227959483615, 11328.773424531504, 11376.658700239006, 11414.0, 10913.945430272877, 11217.943910280477, 11243.60647377338, 11384.772304553862, 11399.0, 35474.64525354765, 39991.80004099961, 40242.0, 40254.0, 40312.39531407031, 3612.8916132516065, 4016.096378314856, 4023.2556976959063, 4078.8368465261356, 4177.0, 25148.622770658272, 27860.0, 32422.189445263823, 32725.672743272502, 33093.83453082719, 3136.0905337452114, 3304.8347582621013, 3324.0, 3348.564686590752, 3354.1446931032674, 486171.0, 489085.0, 495234.0, 496236.0, 497921.0, 69512.0, 70914.64542677253, 71028.0, 71111.2888871115, 71171.64414177896, 48402.75798620984, 59873.0, 60168.0, 60168.09747853786, 60240.0, 16678.58303542421, 16903.98576085439, 16924.57688557796, 16932.915335423244, 16947.491575252763, 11654.242474239147, 11896.702582435508, 12654.620361389174, 12762.936185319015, 12913.677158071123, 17473.47579572615, 17504.076481494027, 21049.158033678483, 21416.250431234832, 21524.0, 7996.72011479607, 8615.793788869563, 9095.909040909506, 9151.496667683341, 9241.584128714225, 891.6700820696254, 898.9775255618531, 907.3285768531372, 926.3145272498438, 938.0713094036854, 28730.712692872803, 29923.551146732818, 30315.393692126036, 30508.847455762578, 30630.0, 1074.8710154781477, 1076.5370890517154, 1112.866456025282, 1118.2116607791488, 1147.7933971884975, 12585.622431327074, 13009.739805203842, 15536.92231538835, 15707.371705131894, 15964.0, 451469.0, 619401.5448841265, 622818.7718122852, 624971.0, 625217.0, 59961.10058349128, 60563.48591285165, 60618.696906515186, 60695.69652151711, 60831.179478975304, 1302.5571305756089, 1435.8564143585559, 1486.970260594782, 1492.3955797901867, 1502.676924461246, 27833.72166278311, 29430.852845735633, 29433.96981105651, 30100.698993010665, 30130.69869301279, 49402.81270466693, 49794.502054978984, 49821.252681210535, 49992.00015999587, 50108.0, 509607.0, 509793.0, 511254.0, 512394.0, 512652.0, 35181.29637407186, 38765.806170968965, 41909.371359430246, 42700.359494606986, 43221.0, 42318.15363692647, 42654.36018459788, 44113.558864412225, 47247.76376118098, 47547.0, 34725.652743472245, 35414.64585354114, 35418.29163416769, 36888.26223475569, 36906.077348066516, 35393.11517211987, 35439.46840797442, 36134.0, 36540.45189322109, 36878.078048049014, 31737.523937141425, 35024.94925152249, 35449.645503544634, 35896.4615530762, 36081.639183607826, 29596.408071838872, 31164.53253201249, 32106.51840222352, 32413.18967025843, 32809.50785738263, 20949.476263093544, 23632.17287394933, 23938.04247830137, 24406.0, 24455.633165502888], "value": 20351.312202225337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.3259800863425, 389.6609949344069, 389.7252437031893, 399.77812314165647, 426.3242760225043, 13006.54477093302, 14779.334929928153, 18049.4585162445, 21044.579108417824, 21117.57764844706, 21729.78270217297, 22488.0, 22615.98228079736, 23021.194258200965, 23147.0, 5631.436856314356, 5747.540196784258, 5870.589058765888, 5899.764009439617, 5975.910361344561, 5791.21818554494, 5907.438793314628, 5912.231409916726, 5916.349201587844, 5929.169916211734, 4149.564295748948, 4348.869533913988, 4372.191144638236, 6439.967800160993, 6535.934640653581, 6271.184745983039, 6500.642464664442, 6515.869682606369, 6529.869402611968, 6533.967330163367, 5704.087346024658, 5770.16332631766, 5779.248697669318, 5783.334916484616, 5787.50806181475, 26345.604815927778, 26641.600375994374, 27266.727332726616, 27359.905603776024, 27512.724872751216, 2737.8220415673118, 2765.2119146043483, 2780.179846945156, 2801.2856721535877, 2830.5895645131545, 15786.21068946548, 15966.121863297514, 15995.92002039994, 16082.356705731874, 16582.25379857909, 1789.168036862865, 1812.28414776164, 1827.5979284557377, 1849.140149830322, 1894.3085773692503, 117491.41254293674, 127147.0, 130043.34978325048, 130146.0, 131017.0, 11256.26834255787, 11262.493187806405, 11576.189666723418, 11621.360825154528, 11669.35818529972, 12859.16415432994, 14756.188409637572, 14808.777868331983, 14946.62633434151, 15109.773353399707, 7225.74709885162, 8579.0, 8844.734657960144, 8995.820083598292, 9023.909760902437, 8672.316948847678, 8742.737717868475, 8780.736577902673, 8961.23829474502, 9011.594478248495, 6023.27720673522, 7339.70641174347, 7353.6323183840595, 7361.889571656322, 7381.88927166093, 1715.8627309815186, 1883.51970247586, 1940.262700173925, 1943.523836659999, 1950.9709901702354, 392.2664617165861, 410.5483967635577, 416.79368712486905, 428.6185295087375, 1017.8498296924575, 11528.0, 11908.940455297668, 11967.700807479883, 12020.699482512833, 12248.877511224951, 444.2916984195762, 447.9776011199427, 453.53739186030066, 458.17757125958985, 461.8060414625798, 4843.854684359475, 5138.691678499227, 5940.524758019435, 5957.493613042853, 6161.0, 696421.0, 715034.0, 724831.0, 741928.0, 755961.2201938955, 126598.36700816621, 159150.0, 160042.0, 160096.0, 164023.0, 444.7376048131618, 457.7985686298018, 459.972401655895, 460.7189614335253, 460.86404510669433, 10494.895051049392, 11169.553217871518, 11620.244684095507, 11934.4032798358, 11936.0, 45958.31062534131, 56452.30643080714, 57704.0, 59113.0, 61603.379746518294, 56736.0, 83291.58354208432, 83453.48918597355, 84158.0, 85491.0, 5713.228714123707, 8148.429609927248, 8319.792005199677, 8454.492730436194, 8708.259797917248, 9008.819823603622, 11946.104042196695, 12965.15726477776, 13038.348082596021, 13432.39554220082, 11273.0, 11360.863913608573, 11673.533058677558, 11895.76208475843, 11972.700682483008, 10821.56713731442, 11279.548818047186, 11443.25618834773, 11654.125940554322, 11723.531058757895, 11432.0, 11522.596709115476, 11840.230385024946, 11860.94069529647, 11909.285442873455, 8171.182881711781, 8220.671173153007, 8391.244787968868, 8436.240738333334, 8544.01743799471, 8133.389995750224, 9679.419234845931, 11058.004779569877, 11261.66215013551, 11668.591599293984], "value": 9040.284314471386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.4040813470535, 1471.8013068235784, 1473.9410423583058, 1486.843881392453, 1491.828439729431, 7514.66184021719, 7797.103333116694, 8171.346292296616, 8599.828003439936, 8622.9652441707, 7735.342495887842, 8138.267555919966, 8402.285805706508, 8418.158184181579, 8515.105913879046, 2319.5476882008056, 2325.221050947926, 2354.8469349492316, 2361.3742358274985, 2365.9053637854463, 2263.0721404224273, 2362.8818559072065, 2368.3960590049514, 2375.67928329675, 2381.833271670984, 2059.104289634014, 2139.6255655260343, 2140.1332460353506, 2211.281333566589, 2316.3051084674617, 2292.32376448948, 2347.847389919667, 2353.3528279723214, 2355.9869256219818, 2356.1164563288767, 2284.8400611957168, 2370.182287110944, 2372.2883135059587, 2381.1070848431837, 2381.868997205153, 8289.958550207271, 8374.958125209396, 8380.958095209546, 8383.874241886377, 8401.0, 5085.389753229599, 5169.302144210521, 5193.870153246199, 5259.421463638997, 5271.657342272779, 3132.530120481923, 3220.565223694818, 3335.366280406715, 3400.727941764678, 3404.0, 1123.7864805686975, 1136.8294755786699, 1161.4599211366672, 1177.6231605886119, 1179.2334982261598, 10421.68734937953, 10519.368837869675, 10636.57453701851, 10658.200634952409, 10665.413402262873, 3810.5236845394325, 4386.64906807461, 4480.641548676098, 4524.16302983949, 4707.105649926503, 9466.148046675833, 9471.868829513442, 9478.57346419399, 9483.525823708787, 9489.0, 4653.348531205634, 5063.696178229318, 5229.607779416559, 5237.8428647140645, 5241.816536421207, 4590.632749380042, 4661.487236403993, 4727.976360118246, 4735.0, 4768.57082862544, 3840.0591854995705, 3853.460515527828, 3917.2557214129793, 3932.390479475686, 3939.3106206413763, 1263.5767018049057, 1283.1210620724646, 1288.62629837348, 1304.8303720516271, 1306.431702209542, 751.8345963888046, 783.647358688581, 791.9485233459807, 794.8489786940463, 816.1960468938091, 4534.229181039232, 5418.295621569171, 5590.692511911884, 5612.0, 5614.438556144434, 531.5136649965316, 544.0723566319416, 567.2115759094861, 568.5082403720752, 715.8031541326072, 3389.6271410144864, 3469.913252168716, 3508.8596456141468, 3770.0951771574623, 3804.9429258561145, 9328.0, 9887.851682224773, 9894.010598940049, 9895.257855660855, 9907.058829411195, 9580.808383832284, 9859.50702464874, 9862.01379862008, 9863.704088877344, 9866.30935834499, 7542.6605802739, 7671.769846904602, 7793.10379306387, 7803.180666029985, 7837.9216207838335, 4035.8183881724804, 5303.946960530346, 5406.540444062299, 5429.131338985743, 5520.751566179451, 8909.73270801877, 8913.37606367548, 8988.685396011108, 9113.225375842863, 9202.861957070783, 9047.909520904706, 9191.586378612845, 9276.16514513697, 9313.860292095489, 9320.72037838866, 6905.620190889348, 6954.165500140016, 7010.754623588354, 7065.682044307916, 7084.433245340258, 7665.88501172494, 7737.0, 7743.0, 7745.109312429143, 7749.883751743616, 6661.833454163685, 6979.476539259677, 7059.929400705927, 7078.079849619517, 7098.609576473344, 6960.408365289007, 6976.19773726028, 7016.333448322402, 7018.613976231356, 7050.5769653820935, 6232.688365581612, 6258.874822503615, 6358.650274234961, 6359.268684101387, 6361.681915904279, 4884.731339776205, 4927.901441971068, 4948.6535942485125, 4967.850964471072, 5048.646594738333, 4852.490488498657, 4896.92654610174, 4965.255211718271, 5038.899222015466, 5105.821296254613], "value": 4305.128182162994, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.5864962045546, 350.3850741947881, 363.60185596771527, 373.27211936723364, 374.7227051981533, 4614.630829533633, 4903.6322275829325, 4965.726885021322, 5154.613403994701, 5242.239875218091, 4257.6806739494505, 5093.71984540851, 5098.337216161903, 5134.691918484884, 5148.69107853529, 3361.9495707564406, 3761.849526018956, 3901.6293452122004, 3963.326234540135, 3973.940390894139, 3492.807895565743, 3694.8152592370407, 4004.259212045766, 4056.290149223889, 4074.8981275468204, 3314.519394687769, 3411.0790086676584, 3538.610752817188, 4038.4144299076615, 4048.0, 3549.3078849624335, 3888.3972984187494, 4065.7763822989723, 4084.2035803018425, 4084.611961863618, 3085.1207405889213, 3555.2000799820094, 3604.5849280981806, 3655.0, 3670.467782171597, 4391.538888416734, 5032.345795046657, 5045.823396181116, 5063.8480845574695, 5093.923591146136, 3947.684185265172, 4664.930026049612, 4726.0784147091335, 4732.290156476522, 4733.982193828343, 4652.162610730067, 4771.928421073687, 4780.613622049602, 4805.678438429425, 5587.944120558824, 3503.915170473564, 3582.4268117101137, 4049.3318602430563, 4052.5339585947404, 4060.5739743679533, 4683.812647494096, 4727.3854398927915, 5227.268182454497, 5495.917561236584, 5694.9430505695245, 3534.3638145134123, 3614.692751116132, 4138.317177665712, 4146.481689788777, 4151.723724563704, 4227.281362168377, 4227.598378154071, 4240.809163587646, 4247.3628955656895, 4252.744835309892, 4206.348016057516, 4516.412866327357, 4739.526047395233, 4754.381930349033, 4778.904421911542, 4897.902041959141, 5524.392316845144, 5570.220169176318, 5575.637583557056, 5608.747606357723, 1191.0, 1225.4607972492074, 1239.4670291774623, 1314.0998416085013, 1381.4198036824557, 784.0, 833.3125171733224, 909.7218408136579, 917.8118485710413, 921.6681994481982, 3998.4402183694306, 4076.775777332216, 4866.416030076342, 4872.805087796449, 4874.488178741181, 5108.693478391308, 5326.174442961347, 5335.733213339317, 5396.541293990055, 5411.56707463402, 4181.937270940938, 4607.401037865056, 4873.00103478786, 4913.582345500672, 4965.950340496621, 2421.413973847133, 2424.709034915786, 2604.0, 2654.9867250663624, 2852.7432531072304, 4867.683600565952, 4946.5407704727195, 5396.703181325065, 5403.513683768401, 5551.777928882881, 4577.8397756078375, 4781.876259079114, 4902.191138462185, 5249.448807875118, 5319.760610772524, 4927.408710954636, 5861.6189947653265, 5871.119332100134, 5910.547122944016, 5912.970435147797, 5395.70323632204, 5682.352117885767, 5696.6897613549945, 5706.4864162225595, 5730.5129064030025, 4458.799354029012, 4717.532613529122, 4922.483139270325, 5112.667676601009, 5622.931642987819, 5375.704336261387, 5492.47821456961, 5593.272874526286, 5688.232088667977, 5852.239208902815, 3699.7595156314756, 3799.7340186186702, 3818.503594532693, 3823.2353529293696, 3826.0626146594263, 5365.65123267002, 5695.288088988877, 5701.572382071278, 5704.3154821421695, 5728.427157284238, 4981.2030075187795, 5103.668261562986, 5298.28473156119, 5484.753186106715, 5543.861403464945, 5469.617126801086, 5484.643498172606, 5504.394516603091, 5523.337199536081, 5532.557395408277, 4712.293156026623, 4885.876248462802, 4900.94629654626, 5004.721907150822, 5387.865303367447, 5433.9675461662155, 5446.509814116748, 5501.697406642673, 5511.834644960658, 5546.94608024474, 5308.495692909168, 5350.545203657733, 5381.381141168816, 5412.891742165213, 5455.863603409946], "value": 3986.964862416785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.6727921516496, 733.8862476316169, 766.4328396986232, 803.0764620686211, 828.3745771942183, 15261.0, 15524.611884702888, 15922.203889805493, 15940.920295398506, 15963.68072638548, 14290.356933937972, 14301.570952871405, 14335.92832035841, 14697.412103515846, 14819.333130009149, 673.636236432326, 692.7609974558769, 698.5040621158984, 833.3957880536593, 853.9274161696247, 854.598338780772, 863.1713554987219, 873.9475631462133, 876.3865294293988, 876.701921346742, 928.7956649537125, 929.0152438415267, 929.739672891588, 929.8512238041915, 931.4969916245219, 707.5294928872294, 730.620077559666, 921.7280902133887, 923.5613083785215, 925.7593025813337, 663.7212370804225, 683.8666460040295, 689.4794430205213, 690.3476214976849, 692.536000879412, 15266.236688165658, 15439.305231264509, 15558.688826223412, 15619.609509762233, 15623.765643515357, 13943.72487717727, 14012.789808152886, 14031.929840350733, 14138.08102473336, 14238.857611423857, 12655.367231638382, 12761.61715148547, 12825.102242843004, 13043.347832608426, 13115.737685246337, 4357.9564204358185, 4419.160359531678, 4442.355858400546, 4444.31113177458, 4459.554044595547, 103663.0, 105718.47140764324, 107418.77743667703, 107656.0, 110922.9999999992, 10701.411422371844, 10781.62264320745, 10969.670909872557, 11079.612213572485, 11404.258723182966, 21948.34154975353, 22370.210383169306, 22370.55258894813, 22396.216132435286, 22405.87970601496, 7496.7001319947685, 7583.0, 7624.27569380908, 7872.881906771403, 7946.920530794618, 4192.4759405074365, 4249.80875860587, 4272.060146767706, 4282.443282373271, 4420.270655341833, 3418.67522585354, 3427.365937301607, 3465.9480107798404, 3487.1805125795418, 3507.4212754895157, 630.6941133550224, 635.3170341882402, 638.6902352359102, 648.3872740260408, 648.8734696734092, 489.9906193241933, 638.5051585021553, 643.8680070585518, 661.0612929639826, 665.7769647168157, 9239.168474837297, 9707.223422126213, 9742.31803773729, 9774.804503910023, 9784.510774461249, 532.1432493685164, 650.4698670583459, 652.774792696519, 661.1174082599783, 663.6781161136845, 4581.5918363275205, 4654.371659825948, 4659.534046595381, 4681.531846815359, 4762.690425122356, 103971.96028039623, 106203.0, 106981.93018069719, 107576.0, 108288.0, 93083.53458232665, 95046.0, 95184.52407737917, 95505.08989820303, 97230.51384743031, 83513.74729379185, 84371.7344239837, 85846.57076714702, 85890.57054714937, 86826.56586717025, 8318.334533237448, 8780.639000954861, 8817.16236957488, 8826.602802874015, 8890.288776897962, 53282.73358633182, 53911.73044134754, 55672.44327556673, 55991.72004140116, 57070.7146464265, 68132.0, 71374.28625713884, 72263.91604125837, 73669.0, 74563.0, 11571.132165087483, 11581.88418115808, 11791.351475668578, 12035.157538972539, 12210.450529726362, 12000.939995299968, 12058.698532536757, 12074.758504829679, 12186.268823870596, 12628.305443200345, 11559.942200288944, 11565.421728913352, 11674.182807203753, 11817.409129543661, 12076.094292928241, 11861.229020113666, 11912.463939122586, 11919.225250358699, 11966.880331196577, 12087.274763514217, 9535.189508891823, 11642.0, 11644.35956022393, 11697.941510292734, 11760.294382337088, 9719.682206565789, 9735.367201131903, 9846.950765246127, 9958.15355694774, 10152.441615710912, 9735.41587504752, 9837.409755414697, 9842.852357214791, 9849.704508864745, 10158.441285729356], "value": 7374.701425076967, "unit": "score"}], "name": "dromaeo_css", "value": 7135.948860443199, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 112.0, 113.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 132.0, 179.0, 114.0, 110.0, 109.0, 109.0, 128.0, 111.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 184.0, 184.0, 183.0, 184.0, 183.0, 182.0, 183.0, 187.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 90.0, 65.0, 61.0, 59.0, 58.0, 74.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 72.0, 86.0, 69.0, 69.0, 68.0, 83.0, 70.0, 69.0, 85.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 84.0, 89.0, 86.0, 89.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 85.0, 87.0, 87.0, 87.0, 85.0, 88.0, 89.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 53.0, 54.0, 55.0, 56.0, 53.0, 54.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 75.0, 77.0, 73.0, 69.0, 71.0, 71.0, 70.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 90.0, 88.0, 101.0, 110.0, 109.0, 83.0, 87.0, 98.0], "value": 94.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 140.0, 141.0, 140.0, 146.0, 174.0, 132.0, 218.0, 190.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 180.0, 173.0, 174.0, 164.0, 174.0, 174.0, 201.0, 238.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 69.0, 68.0, 69.0, 67.0, 66.0, 67.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1458.8, "alertThreshold": 2.0}]} 12:11:19 INFO - Return code: 0 12:11:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:11:19 INFO - # TBPL SUCCESS # 12:11:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:11:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:11:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:11:19 INFO - 2017-01-12 12:11:19.140 screenresolution[2604:287108] starting screenresolution argv=screenresolution get 12:11:19 INFO - 2017-01-12 12:11:19.143 screenresolution[2604:287108] Display 0: 1600x1200x32@60 12:11:19 INFO - 2017-01-12 12:11:19.150 screenresolution[2605:287111] starting screenresolution argv=screenresolution list 12:11:19 INFO - Available Modes on Display 0 12:11:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:11:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:11:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:11:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:11:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:11:19 INFO - Intel Iris: 12:11:19 INFO - Chipset Model: Intel Iris 12:11:19 INFO - Type: GPU 12:11:19 INFO - Bus: Built-In 12:11:19 INFO - VRAM (Dynamic, Max): 1536 MB 12:11:19 INFO - Vendor: Intel (0x8086) 12:11:19 INFO - Device ID: 0x0a2e 12:11:19 INFO - Revision ID: 0x0009 12:11:19 INFO - Displays: 12:11:19 INFO - Display: 12:11:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:11:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:11:19 INFO - Display Serial Number: 1600x1200 60 12:11:19 INFO - Main Display: Yes 12:11:19 INFO - Mirror: Off 12:11:19 INFO - Online: Yes 12:11:19 INFO - Rotation: Supported 12:11:19 INFO - Return code: 0 12:11:19 INFO - Running post-action listener: _resource_record_post_action 12:11:19 INFO - [mozharness: 2017-01-12 20:11:19.387986Z] Finished run-tests step (success) 12:11:19 INFO - Running post-run listener: _resource_record_post_run 12:11:19 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 143360; Write bytes: 551883776; Read time: 2; Write time: 1658 12:11:19 INFO - TinderboxPrint: CPU usage
53.7% 12:11:19 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 2 12:11:19 INFO - TinderboxPrint: I/O write bytes / time
551,883,776 / 1,658 12:11:19 INFO - TinderboxPrint: CPU idle
2,223.5 (46.3%) 12:11:19 INFO - TinderboxPrint: CPU system
963.9 (20.1%) 12:11:19 INFO - TinderboxPrint: CPU user
1,614.3 (33.6%) 12:11:19 INFO - TinderboxPrint: Swap in / out
251,207,680 / 0 12:11:19 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245694976; Write bytes: 239658496; Read time: 17870; Write time: 504 12:11:19 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 143360; Write bytes: 294745600; Read time: 2; Write time: 1098 12:11:19 INFO - Running post-run listener: _upload_blobber_files 12:11:19 INFO - Blob upload gear active. 12:11:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:19 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 12:11:19 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:11:19 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:11:20 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:11:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:11:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:21 INFO - (blobuploader) - INFO - Done attempting. 12:11:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:11:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:11:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:22 INFO - (blobuploader) - INFO - Done attempting. 12:11:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:11:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:23 INFO - (blobuploader) - INFO - Done attempting. 12:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:25 INFO - (blobuploader) - INFO - Done attempting. 12:11:25 INFO - (blobuploader) - INFO - Iteration through files over. 12:11:25 INFO - Return code: 0 12:11:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:11:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:11:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6e1e4e72751ee4eef8c72164d1ec2ec01e009b0b49924df4745440be19de13c27168c88a28273e7387fdbbab48226885697cf44519a98e5897d20e8cd714fe2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/057b03fb7aa69fab1f9edf0bc962a88a784d575f5857a93f2268f72c3cdb013f062cfe8fc9ba3162e1337fd4f7b8f6b595daa925fb99bc132f4057be31785c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6439461ad76414faa9a62312fdb3ddb06fdc2ab049636e79d554eaa7046012fafd3e0eedce75c446aed4b4b32fa033b9bc2a67ee02d0ad99bbc7ede0281f3af7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/226159f41c9caeff8c9260bc3c9d47ccb4502bba6f5f70210e12deb261aef2581d0968ba04a3850b3b999cd219ec2d3878fb4be899115201ab643d93f079e8fb"} 12:11:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:11:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:11:25 INFO - Contents: 12:11:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6e1e4e72751ee4eef8c72164d1ec2ec01e009b0b49924df4745440be19de13c27168c88a28273e7387fdbbab48226885697cf44519a98e5897d20e8cd714fe2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/057b03fb7aa69fab1f9edf0bc962a88a784d575f5857a93f2268f72c3cdb013f062cfe8fc9ba3162e1337fd4f7b8f6b595daa925fb99bc132f4057be31785c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6439461ad76414faa9a62312fdb3ddb06fdc2ab049636e79d554eaa7046012fafd3e0eedce75c446aed4b4b32fa033b9bc2a67ee02d0ad99bbc7ede0281f3af7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/226159f41c9caeff8c9260bc3c9d47ccb4502bba6f5f70210e12deb261aef2581d0968ba04a3850b3b999cd219ec2d3878fb4be899115201ab643d93f079e8fb"} 12:11:25 INFO - Running post-run listener: copy_logs_to_upload_dir 12:11:25 INFO - Copying logs to upload dir... 12:11:25 INFO - mkdir: /builds/slave/test/build/upload/logs 12:11:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.831559 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-12 12:11:25.915461) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 12:11:25.918882) ========= 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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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/Graphics/sha512/6e1e4e72751ee4eef8c72164d1ec2ec01e009b0b49924df4745440be19de13c27168c88a28273e7387fdbbab48226885697cf44519a98e5897d20e8cd714fe2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/057b03fb7aa69fab1f9edf0bc962a88a784d575f5857a93f2268f72c3cdb013f062cfe8fc9ba3162e1337fd4f7b8f6b595daa925fb99bc132f4057be31785c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6439461ad76414faa9a62312fdb3ddb06fdc2ab049636e79d554eaa7046012fafd3e0eedce75c446aed4b4b32fa033b9bc2a67ee02d0ad99bbc7ede0281f3af7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/226159f41c9caeff8c9260bc3c9d47ccb4502bba6f5f70210e12deb261aef2581d0968ba04a3850b3b999cd219ec2d3878fb4be899115201ab643d93f079e8fb"} build_url:https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/KNjTzFhxRyqRUkA9-J51aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6e1e4e72751ee4eef8c72164d1ec2ec01e009b0b49924df4745440be19de13c27168c88a28273e7387fdbbab48226885697cf44519a98e5897d20e8cd714fe2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/057b03fb7aa69fab1f9edf0bc962a88a784d575f5857a93f2268f72c3cdb013f062cfe8fc9ba3162e1337fd4f7b8f6b595daa925fb99bc132f4057be31785c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6439461ad76414faa9a62312fdb3ddb06fdc2ab049636e79d554eaa7046012fafd3e0eedce75c446aed4b4b32fa033b9bc2a67ee02d0ad99bbc7ede0281f3af7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/226159f41c9caeff8c9260bc3c9d47ccb4502bba6f5f70210e12deb261aef2581d0968ba04a3850b3b999cd219ec2d3878fb4be899115201ab643d93f079e8fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 12:11:25.952752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:11:25.953039) ========= 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.SyPjnvWdjH/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.GiaEH6aw8m/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.005363 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:11:26.000848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 12:11:26.001129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 12:11:26.001444) ========= ========= Total master_lag: 0.18 =========