builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0209 starttime: 1493077325.0 results: success (0) buildid: 20170424154625 builduid: 99bc8e20d7f145cfbae10fbf12ced28d revision: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.004148) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.005126) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.005966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.374936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.375310) ========= 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.Ej859Mzh6S/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.lOtWgKhIte/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-04-24 16:42:05-- 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% 64.5M=0s 2017-04-24 16:42:05 (64.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117961 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.519480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.519999) ========= 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.Ej859Mzh6S/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.lOtWgKhIte/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.026739 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:05.569288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 16:42:05.569655) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ej859Mzh6S/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.lOtWgKhIte/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-04-24 16:42:05,677 truncating revision to first 12 chars 2017-04-24 16:42:05,677 Setting DEBUG logging. 2017-04-24 16:42:05,677 attempt 1/10 2017-04-24 16:42:05,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/196e7e9e2e44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 16:42:06,506 unpacking tar archive at: mozilla-central-196e7e9e2e44/testing/mozharness/ program finished with exit code 0 elapsedTime=1.111261 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 16:42:06.707072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:06.707558) ========= script_repo_revision: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:06.708023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:06.708361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:06.729560) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-24 16:42:06.730256) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ej859Mzh6S/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.lOtWgKhIte/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:42:06 INFO - MultiFileLogger online at 20170424 16:42:06 in /builds/slave/test 16:42:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:42:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:06 INFO - {'append_to_log': False, 16:42:06 INFO - 'base_work_dir': '/builds/slave/test', 16:42:06 INFO - 'blob_upload_branch': 'Firefox', 16:42:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:06 INFO - 'branch': 'Firefox', 16:42:06 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:06 INFO - 'config_files': ('talos/mac_config.py',), 16:42:06 INFO - 'default_actions': ('clobber', 16:42:06 INFO - 'read-buildbot-config', 16:42:06 INFO - 'download-and-extract', 16:42:06 INFO - 'populate-webroot', 16:42:06 INFO - 'create-virtualenv', 16:42:06 INFO - 'install', 16:42:06 INFO - 'run-tests'), 16:42:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:06 INFO - 'download_minidump_stackwalk': True, 16:42:06 INFO - 'download_symbols': 'ondemand', 16:42:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:06 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:06 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:06 INFO - 'gecko_profile': False, 16:42:06 INFO - 'gecko_profile_interval': 0, 16:42:06 INFO - 'installer_path': 'installer.exe', 16:42:06 INFO - 'log_level': 'info', 16:42:06 INFO - 'log_name': 'talos', 16:42:06 INFO - 'log_to_console': True, 16:42:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:42:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:42:06 INFO - 'opt_config_files': (), 16:42:06 INFO - 'pip_index': False, 16:42:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:42:06 INFO - 'cmd': ('bash', 16:42:06 INFO - '-c', 16:42:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:42:06 INFO - 'enabled': True, 16:42:06 INFO - 'halt_on_failure': False, 16:42:06 INFO - 'name': 'check_screen_resolution'},), 16:42:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:42:06 INFO - 'cmd': ('bash', 16:42:06 INFO - '-c', 16:42:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:42:06 INFO - 'enabled': True, 16:42:06 INFO - 'halt_on_failure': False, 16:42:06 INFO - 'name': 'check_screen_resolution'},), 16:42:06 INFO - 'run_cmd_checks_enabled': True, 16:42:06 INFO - 'suite': 'dromaeojs', 16:42:06 INFO - 'system_bits': '32', 16:42:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:06 INFO - 'title': 't-yosemite-r7-0209', 16:42:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:06 INFO - 'use_talos_json': True, 16:42:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:06 INFO - 'work_dir': 'build'} 16:42:06 INFO - [mozharness: 2017-04-24 23:42:06.943123Z] Running clobber step. 16:42:06 INFO - Running pre-action listener: _resource_record_pre_action 16:42:06 INFO - Running main action method: clobber 16:42:06 INFO - rmtree: /builds/slave/test/build 16:42:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:09 INFO - Running post-action listener: _resource_record_post_action 16:42:09 INFO - [mozharness: 2017-04-24 23:42:09.475284Z] Finished clobber step (success) 16:42:09 INFO - [mozharness: 2017-04-24 23:42:09.475419Z] Running read-buildbot-config step. 16:42:09 INFO - Running pre-action listener: _resource_record_pre_action 16:42:09 INFO - Running main action method: read_buildbot_config 16:42:09 INFO - Using buildbot properties: 16:42:09 INFO - { 16:42:09 INFO - "project": "", 16:42:09 INFO - "product": "firefox", 16:42:09 INFO - "script_repo_revision": "production", 16:42:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:42:09 INFO - "repository": "", 16:42:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:42:09 INFO - "buildid": "20170424154625", 16:42:09 INFO - "pgo_build": "False", 16:42:09 INFO - "basedir": "/builds/slave/test", 16:42:09 INFO - "buildnumber": 37, 16:42:09 INFO - "slavename": "t-yosemite-r7-0209", 16:42:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:42:09 INFO - "platform": "yosemite_r7", 16:42:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:42:09 INFO - "branch": "mozilla-central", 16:42:09 INFO - "repo_path": "mozilla-central", 16:42:09 INFO - "revision": "196e7e9e2e44fa88b597a2405d0e599e5ee11e5b", 16:42:09 INFO - "stage_platform": "macosx64", 16:42:09 INFO - "builduid": "99bc8e20d7f145cfbae10fbf12ced28d", 16:42:09 INFO - "slavebuilddir": "test" 16:42:09 INFO - } 16:42:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:42:09 INFO - Running post-action listener: _resource_record_post_action 16:42:09 INFO - [mozharness: 2017-04-24 23:42:09.478730Z] Finished read-buildbot-config step (success) 16:42:09 INFO - [mozharness: 2017-04-24 23:42:09.478868Z] Running download-and-extract step. 16:42:09 INFO - Running pre-action listener: _resource_record_pre_action 16:42:09 INFO - Running main action method: download_and_extract 16:42:09 INFO - mkdir: /builds/slave/test/build/tests 16:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:09 INFO - trying https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:42:09 INFO - Downloading https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:42:10 INFO - Downloaded 1325 bytes. 16:42:10 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:42:10 INFO - Using the following test package requirements: 16:42:10 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:42:10 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:42:10 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:42:10 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:42:10 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'jsshell-mac.zip'], 16:42:10 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:42:10 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:42:10 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:42:10 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:42:10 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:42:10 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:10 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:42:10 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:42:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:42:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:42:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:42:12 INFO - Content-Length response header: 52523299 16:42:12 INFO - Bytes received: 52523299 16:42:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:42:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:42:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:42:28 INFO - Fetch https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:42:30 INFO - Content-Length response header: 52523299 16:42:30 INFO - Bytes received: 52523299 16:42:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:42:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:42:45 INFO - Fetch https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:42:46 INFO - Content-Length response header: 14408822 16:42:46 INFO - Bytes received: 14408822 16:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:47 INFO - trying https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:42:49 INFO - Downloaded 71041574 bytes. 16:42:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:42:49 INFO - mkdir: /builds/slave/test/properties 16:42:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:42:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:42:49 INFO - Contents: 16:42:49 INFO - build_url:https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:42:49 INFO - Running post-action listener: _resource_record_post_action 16:42:49 INFO - Running post-action listener: set_extra_try_arguments 16:42:49 INFO - [mozharness: 2017-04-24 23:42:49.988807Z] Finished download-and-extract step (success) 16:42:49 INFO - [mozharness: 2017-04-24 23:42:49.988967Z] Running populate-webroot step. 16:42:49 INFO - Running pre-action listener: _resource_record_pre_action 16:42:49 INFO - Running main action method: populate_webroot 16:42:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:42:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:42:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:42:49 INFO - '--tppagecycles', 16:42:49 INFO - '7'], 16:42:49 INFO - 'tests': ['tsvgm']}}, 16:42:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:42:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:42:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:42:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:42:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:42:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:42:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:42:49 INFO - 'talos_options': ['--disable-e10s'], 16:42:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:42:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:42:49 INFO - 'talos_options': ['--disable-e10s'], 16:42:49 INFO - 'tests': ['damp', 'tps']}, 16:42:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:42:49 INFO - 'tests': ['damp', 'tps']}, 16:42:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:42:50 INFO - 'tests': ['dromaeo_dom']}, 16:42:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:42:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:42:50 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:42:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:42:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:42:50 INFO - 'tests': ['a11yr', 16:42:50 INFO - 'ts_paint', 16:42:50 INFO - 'tpaint', 16:42:50 INFO - 'sessionrestore', 16:42:50 INFO - 'sessionrestore_no_auto_restore', 16:42:50 INFO - 'tabpaint']}, 16:42:50 INFO - 'other-e10s': {'tests': ['a11yr', 16:42:50 INFO - 'ts_paint', 16:42:50 INFO - 'tpaint', 16:42:50 INFO - 'sessionrestore', 16:42:50 INFO - 'sessionrestore_no_auto_restore', 16:42:50 INFO - 'tabpaint']}, 16:42:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:42:50 INFO - 'ts_paint', 16:42:50 INFO - 'tpaint', 16:42:50 INFO - 'sessionrestore', 16:42:50 INFO - 'sessionrestore_no_auto_restore', 16:42:50 INFO - 'tabpaint']}, 16:42:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:42:50 INFO - 'ts_paint', 16:42:50 INFO - 'tpaint', 16:42:50 INFO - 'sessionrestore', 16:42:50 INFO - 'sessionrestore_no_auto_restore', 16:42:50 INFO - 'tabpaint']}, 16:42:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:42:50 INFO - 'tests': ['a11yr', 16:42:50 INFO - 'ts_paint', 16:42:50 INFO - 'tpaint', 16:42:50 INFO - 'sessionrestore', 16:42:50 INFO - 'sessionrestore_no_auto_restore', 16:42:50 INFO - 'tabpaint']}, 16:42:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:42:50 INFO - 'tests': ['a11yr', 16:42:50 INFO - 'ts_paint', 16:42:50 INFO - 'tpaint', 16:42:50 INFO - 'sessionrestore', 16:42:50 INFO - 'sessionrestore_no_auto_restore', 16:42:50 INFO - 'tabpaint']}, 16:42:50 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:42:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:42:50 INFO - 'bloom_basic_ref']}, 16:42:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:42:50 INFO - 'tests': ['tsvgx', 16:42:50 INFO - 'tsvgr_opacity', 16:42:50 INFO - 'tart', 16:42:50 INFO - 'tscrollx', 16:42:50 INFO - 'cart', 16:42:50 INFO - 'tsvg_static']}, 16:42:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:42:50 INFO - 'tsvgr_opacity', 16:42:50 INFO - 'tart', 16:42:50 INFO - 'tscrollx', 16:42:50 INFO - 'cart', 16:42:50 INFO - 'tsvg_static']}, 16:42:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:42:50 INFO - 'talos_options': ['--disable-e10s'], 16:42:50 INFO - 'tests': ['tp5o']}, 16:42:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:42:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:42:50 INFO - 'talos_options': ['--disable-e10s', 16:42:50 INFO - '--xperf_path', 16:42:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:50 INFO - 'tests': ['tp5n']}, 16:42:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:42:50 INFO - 'talos_options': ['--xperf_path', 16:42:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:50 INFO - 'tests': ['tp5n']}}, 16:42:50 INFO - 'talos.zip': {'path': '', 16:42:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:42:50 INFO - Running post-action listener: _resource_record_post_action 16:42:50 INFO - [mozharness: 2017-04-24 23:42:50.007779Z] Finished populate-webroot step (success) 16:42:50 INFO - [mozharness: 2017-04-24 23:42:50.007889Z] Running create-virtualenv step. 16:42:50 INFO - Running pre-action listener: _resource_record_pre_action 16:42:50 INFO - Running main action method: create_virtualenv 16:42:50 INFO - Creating virtualenv /builds/slave/test/build/venv 16:42:50 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 16:42:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:42:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:42:50 INFO - Using real prefix '/tools/python27' 16:42:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:42:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:42:53 INFO - Installing pip.................done. 16:42:53 INFO - Return code: 0 16:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:42:54 INFO - Reading from file tmpfile_stdout 16:42:54 INFO - Output received: 16:42:54 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) 16:42:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:42:54 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')]} 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:54 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')]} 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:54 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:42:54 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 16:42:54 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 16:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:54 INFO - 'HOME': '/Users/cltbld', 16:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:54 INFO - 'LOGNAME': 'cltbld', 16:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:54 INFO - 'MOZ_NO_REMOTE': '1', 16:42:54 INFO - 'NO_EM_RESTART': '1', 16:42:54 INFO - 'PAGER': '/bin/cat', 16:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:54 INFO - 'PWD': '/builds/slave/test', 16:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:54 INFO - 'SHELL': '/bin/bash', 16:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:42:54 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:54 INFO - 'USER': 'cltbld', 16:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:54 INFO - 'XPC_FLAGS': '0x0', 16:42:54 INFO - 'XPC_SERVICE_NAME': '0', 16:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:54 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 16:42:54 INFO - Cleaning up... 16:42:54 INFO - Return code: 0 16:42:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:42:54 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')]} 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:54 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')]} 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:54 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:42:54 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 16:42:54 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 16:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:54 INFO - 'HOME': '/Users/cltbld', 16:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:54 INFO - 'LOGNAME': 'cltbld', 16:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:54 INFO - 'MOZ_NO_REMOTE': '1', 16:42:54 INFO - 'NO_EM_RESTART': '1', 16:42:54 INFO - 'PAGER': '/bin/cat', 16:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:54 INFO - 'PWD': '/builds/slave/test', 16:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:54 INFO - 'SHELL': '/bin/bash', 16:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:42:54 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:54 INFO - 'USER': 'cltbld', 16:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:54 INFO - 'XPC_FLAGS': '0x0', 16:42:54 INFO - 'XPC_SERVICE_NAME': '0', 16:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:54 INFO - Downloading/unpacking psutil>=3.1.1 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:42:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:58 INFO - Installing collected packages: psutil 16:42:58 INFO - Running setup.py install for psutil 16:42:58 INFO - building 'psutil._psutil_osx' extension 16:42:58 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 16:42:58 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 16:42:58 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 16:42:58 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 16:42:59 INFO - building 'psutil._psutil_posix' extension 16:42:59 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 16:42:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:42:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:42:59 INFO - ^ 16:42:59 INFO - 1 warning generated. 16:42:59 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 16:42:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:59 INFO - Successfully installed psutil 16:42:59 INFO - Cleaning up... 16:42:59 INFO - Return code: 0 16:42:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:42:59 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')]} 16:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:59 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')]} 16:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:59 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:42:59 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 16:42:59 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 16:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:59 INFO - 'HOME': '/Users/cltbld', 16:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:59 INFO - 'LOGNAME': 'cltbld', 16:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:59 INFO - 'MOZ_NO_REMOTE': '1', 16:42:59 INFO - 'NO_EM_RESTART': '1', 16:42:59 INFO - 'PAGER': '/bin/cat', 16:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:59 INFO - 'PWD': '/builds/slave/test', 16:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:59 INFO - 'SHELL': '/bin/bash', 16:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:42:59 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:59 INFO - 'USER': 'cltbld', 16:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:59 INFO - 'XPC_FLAGS': '0x0', 16:42:59 INFO - 'XPC_SERVICE_NAME': '0', 16:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:43:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:43:02 INFO - Installing collected packages: mozsystemmonitor 16:43:02 INFO - Running setup.py install for mozsystemmonitor 16:43:02 INFO - Successfully installed mozsystemmonitor 16:43:02 INFO - Cleaning up... 16:43:02 INFO - Return code: 0 16:43:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:43:03 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 16:43:03 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 16:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:03 INFO - 'HOME': '/Users/cltbld', 16:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:03 INFO - 'LOGNAME': 'cltbld', 16:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:03 INFO - 'MOZ_NO_REMOTE': '1', 16:43:03 INFO - 'NO_EM_RESTART': '1', 16:43:03 INFO - 'PAGER': '/bin/cat', 16:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:03 INFO - 'PWD': '/builds/slave/test', 16:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:03 INFO - 'SHELL': '/bin/bash', 16:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:03 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:03 INFO - 'USER': 'cltbld', 16:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:03 INFO - 'XPC_FLAGS': '0x0', 16:43:03 INFO - 'XPC_SERVICE_NAME': '0', 16:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:03 INFO - Downloading/unpacking jsonschema==2.5.1 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:06 INFO - warning: no files found matching '*.txt' 16:43:06 INFO - no previously-included directories found matching 'build' 16:43:06 INFO - no previously-included directories found matching 'dist' 16:43:06 INFO - no previously-included directories found matching '.git*' 16:43:06 INFO - Installing collected packages: jsonschema, functools32 16:43:06 INFO - Running setup.py install for functools32 16:43:06 INFO - warning: no files found matching '*.txt' 16:43:06 INFO - no previously-included directories found matching 'build' 16:43:06 INFO - no previously-included directories found matching 'dist' 16:43:06 INFO - no previously-included directories found matching '.git*' 16:43:06 INFO - Successfully installed jsonschema functools32 16:43:06 INFO - Cleaning up... 16:43:06 INFO - Return code: 0 16:43:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:06 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:43:06 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 16:43:06 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 16:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:06 INFO - 'HOME': '/Users/cltbld', 16:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:06 INFO - 'LOGNAME': 'cltbld', 16:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:06 INFO - 'MOZ_NO_REMOTE': '1', 16:43:06 INFO - 'NO_EM_RESTART': '1', 16:43:06 INFO - 'PAGER': '/bin/cat', 16:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:06 INFO - 'PWD': '/builds/slave/test', 16:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:06 INFO - 'SHELL': '/bin/bash', 16:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:06 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:06 INFO - 'USER': 'cltbld', 16:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:06 INFO - 'XPC_FLAGS': '0x0', 16:43:06 INFO - 'XPC_SERVICE_NAME': '0', 16:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:43:07 INFO - Cleaning up... 16:43:07 INFO - Return code: 0 16:43:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:43:07 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')]} 16:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:07 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')]} 16:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:07 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:43:07 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 16:43:07 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 16:43:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:07 INFO - 'HOME': '/Users/cltbld', 16:43:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:07 INFO - 'LOGNAME': 'cltbld', 16:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:07 INFO - 'MOZ_NO_REMOTE': '1', 16:43:07 INFO - 'NO_EM_RESTART': '1', 16:43:07 INFO - 'PAGER': '/bin/cat', 16:43:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:07 INFO - 'PWD': '/builds/slave/test', 16:43:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:07 INFO - 'SHELL': '/bin/bash', 16:43:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:07 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:07 INFO - 'USER': 'cltbld', 16:43:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:07 INFO - 'XPC_FLAGS': '0x0', 16:43:07 INFO - 'XPC_SERVICE_NAME': '0', 16:43:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:43:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:43:10 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 16:43:10 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 16:43:10 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 16:43:10 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 16:43:10 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 16:43:10 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 16:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:43:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:43:10 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 16:43:10 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 16:43:10 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 16:43:10 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 16:43:10 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 16:43:10 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 16:43:11 INFO - Downloading docopt-0.6.1.tar.gz 16:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:43:11 INFO - Installing collected packages: blobuploader, requests, docopt 16:43:11 INFO - Running setup.py install for blobuploader 16:43:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:43:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:43:11 INFO - Running setup.py install for requests 16:43:12 INFO - Running setup.py install for docopt 16:43:12 INFO - Successfully installed blobuploader requests docopt 16:43:12 INFO - Cleaning up... 16:43:12 INFO - Return code: 0 16:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:12 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')]} 16:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:12 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')]} 16:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:12 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:43:12 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 16:43:12 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 16:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:12 INFO - 'HOME': '/Users/cltbld', 16:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:12 INFO - 'LOGNAME': 'cltbld', 16:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:12 INFO - 'MOZ_NO_REMOTE': '1', 16:43:12 INFO - 'NO_EM_RESTART': '1', 16:43:12 INFO - 'PAGER': '/bin/cat', 16:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:12 INFO - 'PWD': '/builds/slave/test', 16:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:12 INFO - 'SHELL': '/bin/bash', 16:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:12 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:12 INFO - 'USER': 'cltbld', 16:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:12 INFO - 'XPC_FLAGS': '0x0', 16:43:12 INFO - 'XPC_SERVICE_NAME': '0', 16:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7gv7K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-8svSp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-fiZNjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-tkptN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-ygyc_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-g7A5FX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-fldhV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-uq_PZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-pJnJlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-oQb8GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-vdFkaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-KhoEid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-YVKwA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:13 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-rjQkAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:14 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Ef6AWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:14 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-iOcOU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:14 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-mIBUKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:43:14 INFO - Running setup.py install for manifestparser 16:43:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:43:14 INFO - Running setup.py install for mozcrash 16:43:14 INFO - Running setup.py install for mozdebug 16:43:14 INFO - Running setup.py install for mozdevice 16:43:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:43:14 INFO - Running setup.py install for mozfile 16:43:15 INFO - Running setup.py install for mozhttpd 16:43:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozinfo 16:43:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozInstall 16:43:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozleak 16:43:15 INFO - Running setup.py install for mozlog 16:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for moznetwork 16:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozprocess 16:43:16 INFO - Running setup.py install for mozprofile 16:43:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:43:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:43:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:43:16 INFO - Running setup.py install for mozrunner 16:43:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:43:16 INFO - Running setup.py install for mozscreenshot 16:43:16 INFO - Running setup.py install for moztest 16:43:16 INFO - Running setup.py install for mozversion 16:43:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:43:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:43:16 INFO - Cleaning up... 16:43:16 INFO - Return code: 0 16:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:16 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:43:16 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 16:43:16 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 16:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:16 INFO - 'HOME': '/Users/cltbld', 16:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:16 INFO - 'LOGNAME': 'cltbld', 16:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:16 INFO - 'MOZ_NO_REMOTE': '1', 16:43:16 INFO - 'NO_EM_RESTART': '1', 16:43:16 INFO - 'PAGER': '/bin/cat', 16:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:16 INFO - 'PWD': '/builds/slave/test', 16:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:16 INFO - 'SHELL': '/bin/bash', 16:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:16 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:16 INFO - 'USER': 'cltbld', 16:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:16 INFO - 'XPC_FLAGS': '0x0', 16:43:16 INFO - 'XPC_SERVICE_NAME': '0', 16:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-a93YuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-9d8irO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-38eP7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-pboDWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-SokvcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-v9g5YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-nH71g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:17 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-8DsUBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-8JCKCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-B5Mu7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-FVa9YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Atdbys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-oRYqGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-2bV5tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-aEUNa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-KFDW1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:18 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)) 16:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:18 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-m9NNTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:18 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)) 16:43:18 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)) 16:43:18 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)) 16:43:18 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)) 16:43:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43:18 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 16:43:18 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 16:43:18 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 16:43:18 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 16:43:18 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 16:43:18 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 16:43:21 INFO - Downloading blessings-1.6.tar.gz 16:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:43:21 INFO - Installing collected packages: blessings 16:43:21 INFO - Running setup.py install for blessings 16:43:21 INFO - Successfully installed blessings 16:43:21 INFO - Cleaning up... 16:43:22 INFO - Return code: 0 16:43:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:22 INFO - Reading from file tmpfile_stdout 16:43:22 INFO - Current package versions: 16:43:22 INFO - blessings == 1.6 16:43:22 INFO - blobuploader == 1.2.4 16:43:22 INFO - docopt == 0.6.1 16:43:22 INFO - functools32 == 3.2.3-2 16:43:22 INFO - jsonschema == 2.5.1 16:43:22 INFO - manifestparser == 1.1 16:43:22 INFO - mozInstall == 1.12 16:43:22 INFO - mozcrash == 1.0 16:43:22 INFO - mozdebug == 0.1 16:43:22 INFO - mozdevice == 0.50 16:43:22 INFO - mozfile == 1.2 16:43:22 INFO - mozhttpd == 0.7 16:43:22 INFO - mozinfo == 0.9 16:43:22 INFO - mozleak == 0.1 16:43:22 INFO - mozlog == 3.4 16:43:22 INFO - moznetwork == 0.27 16:43:22 INFO - mozprocess == 0.25 16:43:22 INFO - mozprofile == 0.28 16:43:22 INFO - mozrunner == 6.13 16:43:22 INFO - mozscreenshot == 0.1 16:43:22 INFO - mozsystemmonitor == 0.3 16:43:22 INFO - moztest == 0.8 16:43:22 INFO - mozversion == 1.4 16:43:22 INFO - psutil == 3.1.1 16:43:22 INFO - requests == 1.2.3 16:43:22 INFO - wsgiref == 0.1.2 16:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:22 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')]} 16:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:22 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')]} 16:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:22 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:43:22 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 16:43:22 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 16:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:22 INFO - 'HOME': '/Users/cltbld', 16:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:22 INFO - 'LOGNAME': 'cltbld', 16:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:22 INFO - 'MOZ_NO_REMOTE': '1', 16:43:22 INFO - 'NO_EM_RESTART': '1', 16:43:22 INFO - 'PAGER': '/bin/cat', 16:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:22 INFO - 'PWD': '/builds/slave/test', 16:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:22 INFO - 'SHELL': '/bin/bash', 16:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:22 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:22 INFO - 'USER': 'cltbld', 16:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:22 INFO - 'XPC_FLAGS': '0x0', 16:43:22 INFO - 'XPC_SERVICE_NAME': '0', 16:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 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)) 16:43:22 INFO - Cleaning up... 16:43:22 INFO - Return code: 0 16:43:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:43:22 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')]} 16:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:22 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')]} 16:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:22 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 0x10e0e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca03ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, '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.Ej859Mzh6S/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.lOtWgKhIte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 16:43:22 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 16:43:22 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 16:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:22 INFO - 'HOME': '/Users/cltbld', 16:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:22 INFO - 'LOGNAME': 'cltbld', 16:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:22 INFO - 'MOZ_NO_REMOTE': '1', 16:43:22 INFO - 'NO_EM_RESTART': '1', 16:43:22 INFO - 'PAGER': '/bin/cat', 16:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:22 INFO - 'PWD': '/builds/slave/test', 16:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:22 INFO - 'SHELL': '/bin/bash', 16:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:22 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:22 INFO - 'USER': 'cltbld', 16:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:22 INFO - 'XPC_FLAGS': '0x0', 16:43:22 INFO - 'XPC_SERVICE_NAME': '0', 16:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:43:22 INFO - Cleaning up... 16:43:22 INFO - Return code: 0 16:43:22 INFO - Running post-action listener: _resource_record_post_action 16:43:22 INFO - Running post-action listener: _start_resource_monitoring 16:43:22 INFO - Starting resource monitoring. 16:43:22 INFO - [mozharness: 2017-04-24 23:43:22.867824Z] Finished create-virtualenv step (success) 16:43:22 INFO - [mozharness: 2017-04-24 23:43:22.868768Z] Running install step. 16:43:22 INFO - Running pre-action listener: _resource_record_pre_action 16:43:22 INFO - Running main action method: install 16:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:23 INFO - Reading from file tmpfile_stdout 16:43:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:23 INFO - Reading from file tmpfile_stdout 16:43:23 INFO - Output received: 16:43:23 INFO - Usage: mozinstall [options] installer 16:43:23 INFO - Options: 16:43:23 INFO - -h, --help show this help message and exit 16:43:23 INFO - -d DEST, --destination=DEST 16:43:23 INFO - Directory to install application into. [default: 16:43:23 INFO - "/builds/slave/test"] 16:43:23 INFO - --app=APP Application being installed. [default: firefox] 16:43:23 INFO - mkdir: /builds/slave/test/build/application 16:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:43:42 INFO - Reading from file tmpfile_stdout 16:43:42 INFO - Output received: 16:43:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:43:42 INFO - Running post-action listener: _resource_record_post_action 16:43:42 INFO - [mozharness: 2017-04-24 23:43:42.705696Z] Finished install step (success) 16:43:42 INFO - [mozharness: 2017-04-24 23:43:42.705858Z] Running run-tests step. 16:43:42 INFO - Running pre-action listener: _resource_record_pre_action 16:43:42 INFO - Running main action method: run_tests 16:43:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:43:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:43:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:43:42 INFO - 2017-04-24 16:43:42.720 screenresolution[1615:7499] starting screenresolution argv=screenresolution get 16:43:42 INFO - 2017-04-24 16:43:42.723 screenresolution[1615:7499] Display 0: 1600x1200x32@60 16:43:42 INFO - 2017-04-24 16:43:42.728 screenresolution[1616:7502] starting screenresolution argv=screenresolution list 16:43:42 INFO - Available Modes on Display 0 16:43:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:43:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:43:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:43:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:43:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:43:42 INFO - Intel Iris: 16:43:42 INFO - Chipset Model: Intel Iris 16:43:42 INFO - Type: GPU 16:43:42 INFO - Bus: Built-In 16:43:42 INFO - VRAM (Dynamic, Max): 1536 MB 16:43:42 INFO - Vendor: Intel (0x8086) 16:43:42 INFO - Device ID: 0x0a2e 16:43:42 INFO - Revision ID: 0x0009 16:43:42 INFO - Displays: 16:43:42 INFO - Display: 16:43:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:43:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:43:42 INFO - Display Serial Number: 1600x1200 60 16:43:42 INFO - Main Display: Yes 16:43:42 INFO - Mirror: Off 16:43:42 INFO - Online: Yes 16:43:42 INFO - Rotation: Supported 16:43:42 INFO - Return code: 0 16:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:42 INFO - Python 2.7.3 16:43:42 INFO - Return code: 0 16:43:42 INFO - grabbing minidump binary from tooltool 16:43:42 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')]} 16:43:42 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 0x10dec4d30>, '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 0x10ddeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10deb9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:42 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 16:43:42 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 16:43:42 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 16:43:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:43 INFO - Return code: 0 16:43:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:43:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:43 INFO - ENV: RUST_BACKTRACE is now 1 16:43:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:43:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 16:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0209 --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 16:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej859Mzh6S/Render', 16:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:43 INFO - 'HOME': '/Users/cltbld', 16:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:43 INFO - 'LOGNAME': 'cltbld', 16:43:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:43 INFO - 'MOZ_NO_REMOTE': '1', 16:43:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:43 INFO - 'NO_EM_RESTART': '1', 16:43:43 INFO - 'PAGER': '/bin/cat', 16:43:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:43 INFO - 'PWD': '/builds/slave/test', 16:43:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:43 INFO - 'RUST_BACKTRACE': '1', 16:43:43 INFO - 'SHELL': '/bin/bash', 16:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOtWgKhIte/Listeners', 16:43:43 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 16:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:43 INFO - 'USER': 'cltbld', 16:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:43 INFO - 'XPC_FLAGS': '0x0', 16:43:43 INFO - 'XPC_SERVICE_NAME': '0', 16:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 16:43:43 INFO - mozversion application_buildid: 20170424154625 16:43:43 INFO - mozversion application_changeset: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b 16:43:43 INFO - mozversion application_display_name: Nightly 16:43:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:43 INFO - mozversion application_name: Firefox 16:43:43 INFO - mozversion application_remotingname: firefox 16:43:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:43:43 INFO - mozversion application_vendor: Mozilla 16:43:43 INFO - mozversion application_version: 55.0a1 16:43:43 INFO - mozversion platform_buildid: 20170424154625 16:43:43 INFO - mozversion platform_changeset: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b 16:43:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:43:43 INFO - mozversion platform_version: 55.0a1 16:43:43 INFO - using testdate: 1493077423 16:43:43 INFO - actual date: 1493077423 16:43:43 INFO - starting webserver on 'localhost:49246' 16:43:43 INFO - SUITE-START | Running 2 tests 16:43:43 INFO - TEST-START | dromaeo_css 16:43:43 INFO - operating with platform_type : mac_ 16:43:43 INFO - Initialising browser for dromaeo_css test... 16:43:43 INFO - TEST-INFO | started process 1626 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpvFcqVp/profile http://localhost:49246/getInfo.html) 16:43:45 INFO - PID 1626 | __metrics Screen width/height:1600/1200 16:43:45 INFO - PID 1626 | colorDepth:24 16:43:45 INFO - PID 1626 | Browser inner width/height: 1024/689 16:43:45 INFO - PID 1626 | __metrics 16:43:45 INFO - PID 1626 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:43:45 INFO - PID 1626 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:47 INFO - TEST-INFO | 1626: exit 0 16:43:47 INFO - Browser initialized. 16:43:47 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:47 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpvFcqVp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:59 INFO - PID 1628 | RSS: Main: 242618368 16:43:59 INFO - PID 1628 | 16:47:04 INFO - PID 1628 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 16:47:05 INFO - PID 1628 | RSS: Main: 375738368 16:47:05 INFO - PID 1628 | 16:48:49 INFO - PID 1628 | ************************* 16:48:49 INFO - PID 1628 | A coding exception was thrown and uncaught in a Task. 16:48:49 INFO - PID 1628 | 16:48:49 ERROR - PID 1628 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:48:49 INFO - PID 1628 | Full stack: 16:48:49 INFO - PID 1628 | ************************* 16:48:49 INFO - PID 1628 | ************************* 16:48:49 INFO - PID 1628 | A coding exception was thrown and uncaught in a Task. 16:48:49 INFO - PID 1628 | 16:48:49 ERROR - PID 1628 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:48:49 INFO - PID 1628 | Full stack: 16:48:49 INFO - PID 1628 | ************************* 16:48:49 INFO - PID 1628 | ************************* 16:48:49 INFO - PID 1628 | A coding exception was thrown and uncaught in a Task. 16:48:49 INFO - PID 1628 | 16:48:49 ERROR - PID 1628 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:48:49 INFO - PID 1628 | Full stack: 16:48:49 INFO - PID 1628 | ************************* 16:48:49 INFO - PID 1628 | ************************* 16:48:49 INFO - PID 1628 | A coding exception was thrown and uncaught in a Task. 16:48:49 INFO - PID 1628 | 16:48:49 ERROR - PID 1628 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:48:49 INFO - PID 1628 | Full stack: 16:48:49 INFO - PID 1628 | ************************* 16:50:08 INFO - PID 1628 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 16:50:08 INFO - PID 1628 | RSS: Main: 372056064 16:50:08 INFO - PID 1628 | 16:53:11 INFO - PID 1628 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 16:53:11 INFO - PID 1628 | RSS: Main: 320008192 16:53:11 INFO - PID 1628 | 16:56:13 INFO - PID 1628 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 16:56:14 INFO - PID 1628 | RSS: Main: 328904704 16:56:14 INFO - PID 1628 | 16:59:18 INFO - PID 1628 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 16:59:18 INFO - PID 1628 | RSS: Main: 332832768 16:59:18 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 17:02:21 INFO - PID 1628 | RSS: Main: 377704448 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | __start_tp_report 17:02:21 INFO - PID 1628 | _x_x_mozilla_page_load 17:02:21 INFO - PID 1628 | _x_x_mozilla_page_load_details 17:02:21 INFO - PID 1628 | |i|pagename|runs| 17:02:21 INFO - PID 1628 | |0;dojo.html;3486.2156014896636;3490.1274681329683;3542.238418739971;3551.3430015447143;3572.4462708280207;4929.964707411444;5749.166370876221;6001.699915004243;6168.167297414853;6192.814215573529;5984.401559844025;6035.305939816923;6042.516598672107;6047.818565443033;6082.057281121422;5208.322918020662;5227.26818245446;5227.503387178212;5291.947080529184;5299.735013249341;3823.5029446171957;5341.43914888935;5346.786128554853;5354.705491197982;5480.972595137018;5299.708516031616;5339.759710813023;5377.085895397772;5386.111291636876;5400.351957765074;5390.568754499631;5397.946020539784;5403.621746477748;5406.405295417501;5411.134218525017;5155.097857874857;5237.423883372826;5300.098983172831;5313.3092697949405;5407;4404.581564751344;5989.3711160327975;6060.696965151725;6084.117802918597;6095.9695201524155;6441.967790161066;6444.838879028015;6461;6461.61230326182;6467.579607325509;6276.309605943343;6555.868882622369;6565.507586930951;6582.3417658234275;6588.374104460068;6072.332043475214;6080.635161890256;6087.360827113178;6092.543059270483;6108.5418593605655;6441.774537891151;6463.870722585616;6690.230623478362;6729.22613899398;6771.119754431892;5319.414864364994;6354.17395738551;6392.296847346788;6405.743770249138;6412.61524308543;6567.9671601641685;6573.1783527059115;6576.736930522821;6580.407763301326;6586.506012049115;6247.219097612799;6289.779857704958;6376.521760867953;6461.935380646228;6469.547131700736;6182.969085154636;6452.161219041494;6486.67566621667;6489.902651460137;6503.512236582275;5200.063988482034;5201.765920533585;5205.479452054764;5208.739563021833;5239.842804715865;4570.108828778356;4585.610223131004;4643.048175124091;4654.6741728078705;4681.110588988081;6076.75692972285;6159.599626024294;6186.845328866814;6189.102580125857;6240.937590624127;6568.113304703804;6583.80248592543;6586.077949087132;6591.110200123018;6607.471402287805;6196.783112591128;6202.100695399142;6203.565750397429;6207.068939659087;6220.502359811204;5505.724713764296;5624;5629.408912064257;5660.518855897212;5747.453991870766;6739.52823302374;6824.078749368771;6833.384995350442;6835.93164068353;6838.897416538855;6554.508411869224;6570.737170513126;6589.571677840925;6611.33886611335;6611.471082313307;6494.383033611799;6514.022896565553;6711.194656641234;6773.93226067733;6796.76211332601;6444.4844412445955;6446.161998940108;6450.935490645221;6452.12896258999;6456.515761317826;5093.796248150033;6293.118963345044;6365.077063825812;6581.901271481028;6591.802245932629;6229.127922091002;6299.590526615939;6333.018382150774;6341.460975817107;6345.96827015862;6322.272938612118;6349.333320001518;6349.746010159542;6361.300256971822;6385.744570217139;6147.938520614736;6229.221347331583;6235.532335074979;6249.999999999978;6315.652639104894;6320.557560970872;6359.20509936258;6362.809115726535;6363.331850155667;6367.204099487564;6270.15352927349;6304.779332723516;6313.873722525432;6314.052892066226;6322.178116844781 17:02:21 INFO - PID 1628 | |1;ext.html;756.9697212111516;779.9532028078315;794.3962588432792;939.6053657463865;994.4530508220477;26773.732262677368;37182.81408592957;37461.25077498448;37510.249795004085;37580.43629345562;39890;40083.799581002124;40118;40124.99687507814;40211;6083.422074902877;8465.91534084659;8647.178518040808;8653.48079115252;8692.304615630766;6219.689015549227;6297.874042519147;6331.873362532747;6332.335104813974;6343.207099112611;8362.665493380258;8547.145285471466;8553.700620478285;8564.528950907697;8567.057623661392;8503.659853605848;8566.571671416466;8595.570221488932;8603.139686031409;8614.05245423003;8377.204165604318;8454.112318206562;8473.195046470575;8478.872816907751;8483.872741908875;37615.059623509354;37741.433878491844;37777;37796.81101594502;37803.62196378056;3572.499850020999;3592.3892938200306;3592.8203589820664;3598.1544337080763;3599.8380072896784;24708.258752237463;30888.0733577993;30912.69087309143;30919.381612367626;30937.8453107733;3132.0916934089087;3177.094528059515;3186.139742269574;3192.521121831744;3208.358328334319;270502;277732;278180;278237;278587;48755.75622121867;48920.26619600709;48943.5105648939;48966.26550601672;49008;50639.746801265755;50658.74670626697;50677.493225068014;50704.73238169075;50748.49251507438;13506.39221235027;13599;13599.456021759217;13609.251491168081;13627.931860340635;11047.447627618587;11078.169137314733;11092.946170113826;11104.611338603272;11111.55553777856;10911.290766100337;10940.12479001678;10953.17851161166;12238.571649992386;12581.245125292511;5024.944761600105;5157.484251574812;5159.819406320836;5174.43081261061;5188.377394712583;895.8835351404276;988.5057471264367;999.2505620784411;1009.6819501856892;1056.7886422715487;20532.58934821295;20600.38198854037;21668.45828854291;23861.880690596437;24062.15782447606;1098.1599076706325;1109.4452773613193;1135.0692432205676;1143.74837535742;1154.7921374152734;11466.509353783955;11823.349715765715;12153.149279550347;12200.572979945659;12272.509099636092;252982;290505;290783.54608226824;290871;291040;53016.20475692867;53027.93944121096;53181.93636127333;53336.73331633317;53501.66245843885;1440.3662388549005;1475.4172102019643;1516.3328135620513;1521.9010764300285;1540.8690261327688;21831.781682182977;23185.72478513698;23331.533369332177;23347;23347.649785253576;37778;37875;37903;37969.810150949066;37975.43036854504;272008;272327;272567.2743272542;273280;273582;33908.830455847565;34002.14994625154;34046.63813447434;34088.65911340855;34097.65902340945;45267.64197074093;45332;45368.31947520856;45386.77306613446;45448;29534.852325738233;29916;30197.7920883171;31069.689303107585;31310.373792523565;30389.848050759603;31024.22439439032;31028.379432411675;31138.688613114486;31424;36478;36523.26953460969;37129.257414852094;37392;37450.87647370583;30047.549286760277;30831.38337233198;31222.531662025543;31381.8430907844;31445.213869653442;21233;22785.88607056954;22886.084556618214;24019.639705404083;24392.146274880295 17:02:21 INFO - PID 1628 | |2;jquery.html;384.3466107617048;425.8408885749049;435.19271750902067;439.7625282347532;456.4935712149904;17284.999999999985;21029.894850525747;21774.782252177494;21792.346229613097;22047.22834700786;22192;22732.20437284691;23117.653235201484;23152;23467;6142.600730952485;6162.383761623847;6182.72177752;6210.65841378724;6311.084892690557;3691.741578089535;3736.308782875177;6137.294211165706;6267.592606480587;6278.183836101301;5950.880982380349;6195.659238741868;6206.472449841769;6230.28351739549;6242.687865606701;5891.322497912752;6098.603590766586;6200.503959683215;6210.906836397435;6211.90682139766;5493.725313734337;5493.972530137324;5495.093309603911;5496.5053145217125;5497.45025497451;27431.314217144532;27781;28324.00865969681;28459.57310640342;28655.85672071647;1922.8365588924958;2144.4424449643047;2253.042456955787;2255.2444930948154;2257.266388423769;17459.738103928452;17624.383146589935;18051.021581439178;18164;18277.451676449728;2066.390414827614;2151.95696086079;2171.3160354488446;2173.3914503938922;2177.00946069538;159025;159938.20030899887;160519;161213;166320;10373.429461379546;11376;11694.649160525198;12144.392780360946;12382.75234495305;13537.279243331039;15946.122963237134;16010.279537420844;16293.918530407509;16314.75527867083;8619.103797164613;8704.608292626846;8789.560521974003;8954.820903581893;8975.057618950046;8314.501129932223;8326.958365208135;8362.289205417608;8477.152284771597;8502.617382217815;7550.7734767957045;7667.386609071261;7689.653965571562;7697.268759467842;7704.73033443838;1857.9163937622839;2108.820750236247;2127.6383014887506;2145.2277180215424;2310.5905397707384;842.6376658037103;944.3436811416137;951.3530799056708;952.1668540027476;957.2581249531669;20930;20990.160393584392;21076.89461552713;21123.471913202295;21140.83725395118;965.7979806042235;992.1864071461476;1012.5949620151998;1012.7569383347943;1028.3289654311743;10593.09958653523;10827.458627068616;10830.67507974762;10838;10840.837387439195;499431.50284248346;554129;565859;571831;578660;128226.35886820692;128824;130425;133438;136600.31699841438;1164.889335513125;1174.4186627619383;1232.6856651553976;1247.52594014274;1248.5942068827485;20091.69403988736;20840;21077;21253.46866328292;21256.893715531325;57582.84834303207;58414.7079264601;58582.707086464296;58864.70567647134;59371.515712107546;79449.60275198588;79466.41067178508;80513;80795.59602201951;82023.5898820502;8680.565971701515;8758.299336053227;8762.283692055484;8793.956030219808;8900.643974240958;13702.93148534251;13753.38109785082;14010.859891400956;14061.789073164115;14121.858781412055;11202;11469.942650286695;11716.41417929083;11973.461194246105;12066.879331206927;10913.39976301311;11129.276597021168;11153.83269250978;11449.484773185393;11481.024112950492;10168.186545076524;11377;11474.713132171762;11702.473388697359;11921;6710.530262881552;8440;8623.353248506262;8782.516961567175;8950.68672596456;10046.8492972604;11209.831852522055;11407.030402415887;11736.295822250693;11936.343501107522 17:02:21 INFO - PID 1628 | |3;mootools.html;1401.6145559971008;1449.768037114062;1477.3204326010034;1479.0534058202745;1480.962975925601;11252.324860508365;11839.408029598519;11856.940715296421;11871.940640296787;11885.405729713522;11475.311481311128;11852.111091668115;11855.7628847423;11863.110266729987;11867;2509.1845150326126;2546.8726563671835;2548.4903019396197;2556.9360765980905;2559.8848051837617;2104.705341252226;2166.5558560495137;2400.2079313826393;2532.278300684305;2534.733852945442;2154.482924098221;2186.4861757487056;2187.387531491185;2187.9343619691354;2189.8357623178326;2387.510560335127;2452.3256104571205;2455.5579995600783;2456.054419048661;2457.496213276283;2328.6157783965627;2363.61000434928;2369.5734767741974;2370.573296806574;2380.9166679166146;11519.827202591969;11800.645980620595;11807.763844723144;11833.585824496102;11858.46636901333;6523.18460192476;6782.932170678279;6785.491088168358;6791.728330866808;6815.386615204656;3981.223661386031;4290.806913688892;4382.474103107647;4382.474103107647;4389;1225.5281716539196;1248.8938440232591;1297.4420998970438;1297.6236891301512;1298.3183828490023;16461.176941152895;16593.66812663752;16604;16618.916905415397;16633.584160395843;5343.251944727741;5493.450654934474;5740.6268592541355;5751.396103409165;5756.30924289088;12322.137450378388;12342.259464432163;12343.938280308721;12345.197562158432;12345.93827030859;6606.867862642816;6617.43751781104;6617.569857959217;6619.966900165468;6629.171353580802;5980.611260268069;6126.111713801474;6169.259688837278;6255.56211065221;6260.593061450991;4204.498323497514;4329.155814616182;4369.453818272716;4383.715058521186;4401.097774956126;1256.4220458589152;1270.917390369623;1279.1557572002434;1293.5213970830853;1331.6937104466026;700.9474289428314;761.4137114421865;793.0998316910233;814.8003739083962;819.6762278899802;5907.232059832194;5961.761529538857;6086.6348019119;6332.873342533124;6344.429001389804;918.2791508665799;922.423485321674;946.4557879219476;969.5249327829313;981.617169303972;3224.85517641234;3236.4983427568295;3415.2848485454124;3909.179072394829;3928.744631598994;14555.92722036383;15191.94908687313;15197.240137993056;15209.163496007826;15249.847501525064;14508.854911450962;14888.330025148894;15201.011934224462;15226;15250.771238431433;8413.747587572383;8530.658773648984;8594.613242403982;8699.434536755218;8700.12998700125;6578.868422631616;6762.8647427052165;6796;6809.931900681128;6812.352826481674;13298.468061277441;13398.397072131582;13492.190468571916;13516.459341626225;13552.93223533876;13700.109492882932;13742.93128534391;13749.968752343415;13833.584992450242;14105.6473588157;8558.743237702878;8730;8736.039035706195;8736.519491428033;8764.868526971974;8383.874241886499;9767.511624418608;9919.15687166599;10099.899001009895;10126.44304563256;9058.90941090607;9081.954590227007;9111.635534578543;9120.084782195812;9213.723588292361;7217.350438460564;8882.955585222033;8932.687355942511;9040;9098.454092754457;8122.918770812453;8245.752627421187;8248.298894594027;8250.051244107004;8257.545834979133;4784.40194975628;5602.439756024365;6011.849703757266;6149.84625384369;6220.7511699531515;6057.121717351048;6202.162708034358;6213.720382582705;6237.220347456568;6378.6810659467765 17:02:21 INFO - PID 1628 | |4;prototype.html;392.88017154767795;399.8820347997341;404.93483235498957;406.1106177471336;411.21458015190973;5822.6215296005785;5861.76552937883;5870.559708021894;5882.6764527950945;5890.64656120633;4985.476524964881;5583.469570390806;5664.150377443386;5693.743781529831;5740.56945729071;3635.781853088823;3756.2299728555718;4413.61664701061;4418.690691651585;4431.955680443195;3747.7376583639157;4435.832255422429;4451.710638808483;4452.97773511132;4454.777261136946;3786.469894214812;4197.391378250152;4341.934870976938;4405.625521830648;4408.647308215335;4363.759993200372;4368.563143685606;4389.582989615981;4404.845830395937;4406.801693923749;3409.5056216848666;3886.805659717003;3900.6294402031763;3901.0247438140464;3909.4331321958443;4320.1143765527995;5036.798528058874;5383.380911195223;5534.252875861747;5588.066265210756;4827.686200396963;4872.317875497433;5285.7885684572575;5291.682499050069;5298.523132918056;4890.755462226874;6111.96944015277;6128.509719222451;6144.96927515364;6154.907676384858;3781.640744129303;4071.918561628751;4458.152950939344;4460;4467.687261891669;5287.391949925769;5866.648001119904;6273.498120150377;6409.391107844747;6475.449586785129;4135.379693046068;4206.730168878591;4495.842645507391;4617.145828021827;4632.170292734419;3871.399933010388;3901.8244179012013;4708.858734237979;4717.976410117927;4733.219018861918;4116.197341518435;4465.88352911772;4798.688085274446;5046.873828154326;5333.893112220651;5693.718913244486;5854.824355269348;5905.793297234576;6155.599886007395;6162.568620196633;1551.612096975756;1552.4954389823354;1556.789833372503;1574.5748647865241;1604.7271963766188;1096.6381094238882;1100.6863044032411;1115.726646971481;1116.2465335898237;1133.5465813674596;5825.951328760779;5858.121281807677;5869.677167755729;5870.295564532198;5874.148248504029;5391.7034563099405;5508.14623733322;6032.788852390146;6404.807855764335;6408.903866442007;5547.77808887648;5687.488126068591;5836.503897168704;5859.882802344015;5876.206712093898;2770.459760346713;3188.7767856250302;3267.2648654053123;3331.800091994488;3338.415777239022;5564.860878478071;6587.703553340111;6611.760237483694;6633.6019838809825;6635.288944849115;5662.518685911661;5883.61756485827;6558.606483610999;6572.80281591553;6585.407313341726;5857.062869940789;5917.260342457193;6142.58100285203;6168.920438923171;6501.804945851632;5240.921386179287;5964.135200396005;6049.606775559574;6327.493800496041;6345.17512723343;6041.214642096499;6252.781152659635;6259.216123404808;6263.874722505616;6280.528960328085;5346.572274218131;6159.507239420746;6479;6486.5459417842185;6488.513361497812;4241.575842415858;4257.361395790656;4265.9761657201425;4276.166147601312;4320.2655548556195;6136.110264011782;6366.554341196072;6403.423691867754;6416.486681065597;6419.390157934989;5886.3525012247765;6197.876042479035;6205.689715514297;6232.348427666581;6247.437730604267;5767.84643071379;6008.819735407945;6204.7828326008375;6215.564910456224;6234.2830574482705;5750.913736294043;5822.176244521488;6091.878162436815;6095.481884039907;6128.142060111677;6231.158793562811;6234.407731265523;6236.75052997875;6239.937600623935;6270.2475702915945;5133.204353325241;5563.944360556343;5636.098224284095;5763.510101641407;5931.673757943355 17:02:21 INFO - PID 1628 | |5;yui.html;703.1316324339437;807.1363640904235;825.088277453414;839.4711331860926;864.6238886084552;13019.34903254837;17703.203355848986;17974.460766177002;18315;18395.172217250223;16621.66756664866;16792.412265570707;17254.137293135325;17277.481675549723;17533.473995780147;913.9086091390841;936.180841763457;938.995305023474;939.6570251858057;940.0975063938627;675.5237557521936;689.3554526517722;946.2051876423802;977.6529332087114;992.1120597065621;1037.424229552598;1039.9756240103493;1040.0795296162876;1040.8907064758205;1042.8696412948382;1012.3065699995526;1014.7919676466344;1017.3946501831399;1020.0870221152102;1023.7542989682497;754.3587950242305;755.1165136789969;755.3466251692302;756.4213376766778;761.8476304739074;15843.841561584351;16247.943883647526;16367;16381.754273685905;16655.583610409714;16066.116363599996;16231.83768162315;16300.184990750533;16468.917655411766;16556.42052528168;15476.76784848228;15613.765793513106;15665.451709190123;15785.210739463097;15851.27495038665;5255.211718242256;5283.603729720248;5283.788648454096;5286.444923283077;5294.814681486168;89657;94442;123158.87813313717;125415.37292313571;130643.20175986744;11093.611723589796;11267;12863.871361286454;13160.210387376788;13428.664283392798;17920.283188672307;20262.189512419634;24532;25283.367915801886;25405.237842864743;7579.279968402993;7820.139784623687;7840.490368126054;7849.450538462367;7913.723019694283;3225.741940644743;3737.1965027519213;3804.5814960354337;3806.5241844769403;3813.5423749149722;3798.753081049723;4300.1399720056115;4312.849050283225;4461.955380446219;4478.395416618715;859.7678626770737;892.8660700894787;896.587569717924;896.8475359188823;899.1053901368181;599.5293694449836;645.3578689204272;670.731707317077;676.546713701821;696.1576492444098;9443.905560944302;10687.305325153995;11555.480003399867;11716;11851.22967007159;650.5933791380387;653.5849735418044;660.7984564707714;667.576089183372;689.290031267795;5052.368453943257;5366.838994830161;5377.5429088527135;5503.669779813224;5574.972125139429;77524.61237693776;82599.17400825914;104558.47720761347;105310;108359.30632142484;90422;90872;91674.1665166693;93451.53274233585;94497.58253626201;65326;70971.64514177499;74794;84097;84287.8928026792;8319.792005199919;11086.667399978014;11135.276207046516;11309.982101610894;11323.660290191307;41357;42614.57385426106;42708;43385.78307108444;43999.68000959976;54435.366938991894;55100;56171.71914140403;56274.43725562856;56339.71830140823;13575.93212033973;13776.380062896993;13958.860411395755;13969.022168448111;14042.438302467786;17784.644307113525;17984.730229046312;18715.719264210777;18809.90595047016;18852.622947540698;16439.753403698716;16787.58031049185;17229.39697110595;17420.912895435442;17552.648947020734;16890.74663880018;17024.74462883033;17140.742888856428;17336.739948901028;17477.475675729747;15554.300056497712;15805.36778528846;15919.68160636804;16045.19774011318;16155.111468868854;11525.654230373102;11675.416229188337;11883.821742673694;11937.46281417321;11980.700482488008;11805.940970295094;12900.870991289967;12993.350332483149;13930.094543854617;13949.58151255464 17:02:21 INFO - PID 1628 | __end_tp_report 17:02:21 INFO - PID 1628 | __start_cc_report 17:02:21 INFO - PID 1628 | _x_x_mozilla_cycle_collect,1421 17:02:21 INFO - PID 1628 | __end_cc_report 17:02:21 INFO - PID 1628 | __startTimestamp1493078541518__endTimestamp 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | ------- Summary: start ------- 17:02:21 INFO - PID 1628 | Number of tests: 6 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | [#0] dojo.html Cycles:165 Average:5981.20 Median:6247.22 stddev:727.06 (11.6%) stddev-sans-first:702.45 17:02:21 INFO - PID 1628 | Values: 3486.2 3490.1 3542.2 3551.3 3572.4 4930.0 5749.2 6001.7 6168.2 6192.8 5984.4 6035.3 6042.5 6047.8 6082.1 5208.3 5227.3 5227.5 5291.9 5299.7 3823.5 5341.4 5346.8 5354.7 5481.0 5299.7 5339.8 5377.1 5386.1 5400.4 5390.6 5397.9 5403.6 5406.4 5411.1 5155.1 5237.4 5300.1 5313.3 5407.0 4404.6 5989.4 6060.7 6084.1 6096.0 6442.0 6444.8 6461.0 6461.6 6467.6 6276.3 6555.9 6565.5 6582.3 6588.4 6072.3 6080.6 6087.4 6092.5 6108.5 6441.8 6463.9 6690.2 6729.2 6771.1 5319.4 6354.2 6392.3 6405.7 6412.6 6568.0 6573.2 6576.7 6580.4 6586.5 6247.2 6289.8 6376.5 6461.9 6469.5 6183.0 6452.2 6486.7 6489.9 6503.5 5200.1 5201.8 5205.5 5208.7 5239.8 4570.1 4585.6 4643.0 4654.7 4681.1 6076.8 6159.6 6186.8 6189.1 6240.9 6568.1 6583.8 6586.1 6591.1 6607.5 6196.8 6202.1 6203.6 6207.1 6220.5 5505.7 5624.0 5629.4 5660.5 5747.5 6739.5 6824.1 6833.4 6835.9 6838.9 6554.5 6570.7 6589.6 6611.3 6611.5 6494.4 6514.0 6711.2 6773.9 6796.8 6444.5 6446.2 6450.9 6452.1 6456.5 5093.8 6293.1 6365.1 6581.9 6591.8 6229.1 6299.6 6333.0 6341.5 6346.0 6322.3 6349.3 6349.7 6361.3 6385.7 6147.9 6229.2 6235.5 6250.0 6315.7 6320.6 6359.2 6362.8 6363.3 6367.2 6270.2 6304.8 6313.9 6314.1 6322.2 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | [#1] ext.html Cycles:180 Average:42991.20 Median:34067.65 stddev:72700.44 (213.4%) stddev-sans-first:72835.23 17:02:21 INFO - PID 1628 | Values: 757.0 780.0 794.4 939.6 994.5 26773.7 37182.8 37461.3 37510.2 37580.4 39890.0 40083.8 40118.0 40125.0 40211.0 6083.4 8465.9 8647.2 8653.5 8692.3 6219.7 6297.9 6331.9 6332.3 6343.2 8362.7 8547.1 8553.7 8564.5 8567.1 8503.7 8566.6 8595.6 8603.1 8614.1 8377.2 8454.1 8473.2 8478.9 8483.9 37615.1 37741.4 37777.0 37796.8 37803.6 3572.5 3592.4 3592.8 3598.2 3599.8 24708.3 30888.1 30912.7 30919.4 30937.8 3132.1 3177.1 3186.1 3192.5 3208.4 270502.0 277732.0 278180.0 278237.0 278587.0 48755.8 48920.3 48943.5 48966.3 49008.0 50639.7 50658.7 50677.5 50704.7 50748.5 13506.4 13599.0 13599.5 13609.3 13627.9 11047.4 11078.2 11092.9 11104.6 11111.6 10911.3 10940.1 10953.2 12238.6 12581.2 5024.9 5157.5 5159.8 5174.4 5188.4 895.9 988.5 999.3 1009.7 1056.8 20532.6 20600.4 21668.5 23861.9 24062.2 1098.2 1109.4 1135.1 1143.7 1154.8 11466.5 11823.3 12153.1 12200.6 12272.5 252982.0 290505.0 290783.5 290871.0 291040.0 53016.2 53027.9 53181.9 53336.7 53501.7 1440.4 1475.4 1516.3 1521.9 1540.9 21831.8 23185.7 23331.5 23347.0 23347.6 37778.0 37875.0 37903.0 37969.8 37975.4 272008.0 272327.0 272567.3 273280.0 273582.0 33908.8 34002.1 34046.6 34088.7 34097.7 45267.6 45332.0 45368.3 45386.8 45448.0 29534.9 29916.0 30197.8 31069.7 31310.4 30389.8 31024.2 31028.4 31138.7 31424.0 36478.0 36523.3 37129.3 37392.0 37450.9 30047.5 30831.4 31222.5 31381.8 31445.2 21233.0 22785.9 22886.1 24019.6 24392.1 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | [#2] jquery.html Cycles:180 Average:36005.89 Median:2254.14 stddev:94396.70 (4187.7%) stddev-sans-first:94623.62 17:02:21 INFO - PID 1628 | Values: 384.3 425.8 435.2 439.8 456.5 17285.0 21029.9 21774.8 21792.3 22047.2 22192.0 22732.2 23117.7 23152.0 23467.0 6142.6 6162.4 6182.7 6210.7 6311.1 3691.7 3736.3 6137.3 6267.6 6278.2 5950.9 6195.7 6206.5 6230.3 6242.7 5891.3 6098.6 6200.5 6210.9 6211.9 5493.7 5494.0 5495.1 5496.5 5497.5 27431.3 27781.0 28324.0 28459.6 28655.9 1922.8 2144.4 2253.0 2255.2 2257.3 17459.7 17624.4 18051.0 18164.0 18277.5 2066.4 2152.0 2171.3 2173.4 2177.0 159025.0 159938.2 160519.0 161213.0 166320.0 10373.4 11376.0 11694.6 12144.4 12382.8 13537.3 15946.1 16010.3 16293.9 16314.8 8619.1 8704.6 8789.6 8954.8 8975.1 8314.5 8327.0 8362.3 8477.2 8502.6 7550.8 7667.4 7689.7 7697.3 7704.7 1857.9 2108.8 2127.6 2145.2 2310.6 842.6 944.3 951.4 952.2 957.3 20930.0 20990.2 21076.9 21123.5 21140.8 965.8 992.2 1012.6 1012.8 1028.3 10593.1 10827.5 10830.7 10838.0 10840.8 499431.5 554129.0 565859.0 571831.0 578660.0 128226.4 128824.0 130425.0 133438.0 136600.3 1164.9 1174.4 1232.7 1247.5 1248.6 20091.7 20840.0 21077.0 21253.5 21256.9 57582.8 58414.7 58582.7 58864.7 59371.5 79449.6 79466.4 80513.0 80795.6 82023.6 8680.6 8758.3 8762.3 8794.0 8900.6 13702.9 13753.4 14010.9 14061.8 14121.9 11202.0 11469.9 11716.4 11973.5 12066.9 10913.4 11129.3 11153.8 11449.5 11481.0 10168.2 11377.0 11474.7 11702.5 11921.0 6710.5 8440.0 8623.4 8782.5 8950.7 10046.8 11209.8 11407.0 11736.3 11936.3 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | [#3] mootools.html Cycles:180 Average:7063.42 Median:3918.96 stddev:4545.49 (116.0%) stddev-sans-first:4538.33 17:02:21 INFO - PID 1628 | Values: 1401.6 1449.8 1477.3 1479.1 1481.0 11252.3 11839.4 11856.9 11871.9 11885.4 11475.3 11852.1 11855.8 11863.1 11867.0 2509.2 2546.9 2548.5 2556.9 2559.9 2104.7 2166.6 2400.2 2532.3 2534.7 2154.5 2186.5 2187.4 2187.9 2189.8 2387.5 2452.3 2455.6 2456.1 2457.5 2328.6 2363.6 2369.6 2370.6 2380.9 11519.8 11800.6 11807.8 11833.6 11858.5 6523.2 6782.9 6785.5 6791.7 6815.4 3981.2 4290.8 4382.5 4382.5 4389.0 1225.5 1248.9 1297.4 1297.6 1298.3 16461.2 16593.7 16604.0 16618.9 16633.6 5343.3 5493.5 5740.6 5751.4 5756.3 12322.1 12342.3 12343.9 12345.2 12345.9 6606.9 6617.4 6617.6 6620.0 6629.2 5980.6 6126.1 6169.3 6255.6 6260.6 4204.5 4329.2 4369.5 4383.7 4401.1 1256.4 1270.9 1279.2 1293.5 1331.7 700.9 761.4 793.1 814.8 819.7 5907.2 5961.8 6086.6 6332.9 6344.4 918.3 922.4 946.5 969.5 981.6 3224.9 3236.5 3415.3 3909.2 3928.7 14555.9 15191.9 15197.2 15209.2 15249.8 14508.9 14888.3 15201.0 15226.0 15250.8 8413.7 8530.7 8594.6 8699.4 8700.1 6578.9 6762.9 6796.0 6809.9 6812.4 13298.5 13398.4 13492.2 13516.5 13552.9 13700.1 13742.9 13750.0 13833.6 14105.6 8558.7 8730.0 8736.0 8736.5 8764.9 8383.9 9767.5 9919.2 10099.9 10126.4 9058.9 9082.0 9111.6 9120.1 9213.7 7217.4 8883.0 8932.7 9040.0 9098.5 8122.9 8245.8 8248.3 8250.1 8257.5 4784.4 5602.4 6011.8 6149.8 6220.8 6057.1 6202.2 6213.7 6237.2 6378.7 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | [#4] prototype.html Cycles:180 Average:4998.46 Median:5585.77 stddev:1509.68 (27.0%) stddev-sans-first:1473.81 17:02:21 INFO - PID 1628 | Values: 392.9 399.9 404.9 406.1 411.2 5822.6 5861.8 5870.6 5882.7 5890.6 4985.5 5583.5 5664.2 5693.7 5740.6 3635.8 3756.2 4413.6 4418.7 4432.0 3747.7 4435.8 4451.7 4453.0 4454.8 3786.5 4197.4 4341.9 4405.6 4408.6 4363.8 4368.6 4389.6 4404.8 4406.8 3409.5 3886.8 3900.6 3901.0 3909.4 4320.1 5036.8 5383.4 5534.3 5588.1 4827.7 4872.3 5285.8 5291.7 5298.5 4890.8 6112.0 6128.5 6145.0 6154.9 3781.6 4071.9 4458.2 4460.0 4467.7 5287.4 5866.6 6273.5 6409.4 6475.4 4135.4 4206.7 4495.8 4617.1 4632.2 3871.4 3901.8 4708.9 4718.0 4733.2 4116.2 4465.9 4798.7 5046.9 5333.9 5693.7 5854.8 5905.8 6155.6 6162.6 1551.6 1552.5 1556.8 1574.6 1604.7 1096.6 1100.7 1115.7 1116.2 1133.5 5826.0 5858.1 5869.7 5870.3 5874.1 5391.7 5508.1 6032.8 6404.8 6408.9 5547.8 5687.5 5836.5 5859.9 5876.2 2770.5 3188.8 3267.3 3331.8 3338.4 5564.9 6587.7 6611.8 6633.6 6635.3 5662.5 5883.6 6558.6 6572.8 6585.4 5857.1 5917.3 6142.6 6168.9 6501.8 5240.9 5964.1 6049.6 6327.5 6345.2 6041.2 6252.8 6259.2 6263.9 6280.5 5346.6 6159.5 6479.0 6486.5 6488.5 4241.6 4257.4 4266.0 4276.2 4320.3 6136.1 6366.6 6403.4 6416.5 6419.4 5886.4 6197.9 6205.7 6232.3 6247.4 5767.8 6008.8 6204.8 6215.6 6234.3 5750.9 5822.2 6091.9 6095.5 6128.1 6231.2 6234.4 6236.8 6239.9 6270.2 5133.2 5563.9 5636.1 5763.5 5931.7 17:02:21 INFO - PID 1628 | 17:02:21 INFO - PID 1628 | [#5] yui.html Cycles:180 Average:20985.92 Median:22397.09 stddev:28860.39 (128.9%) stddev-sans-first:28901.16 17:02:21 INFO - PID 1628 | Values: 703.1 807.1 825.1 839.5 864.6 13019.3 17703.2 17974.5 18315.0 18395.2 16621.7 16792.4 17254.1 17277.5 17533.5 913.9 936.2 939.0 939.7 940.1 675.5 689.4 946.2 977.7 992.1 1037.4 1040.0 1040.1 1040.9 1042.9 1012.3 1014.8 1017.4 1020.1 1023.8 754.4 755.1 755.3 756.4 761.8 15843.8 16247.9 16367.0 16381.8 16655.6 16066.1 16231.8 16300.2 16468.9 16556.4 15476.8 15613.8 15665.5 15785.2 15851.3 5255.2 5283.6 5283.8 5286.4 5294.8 89657.0 94442.0 123158.9 125415.4 130643.2 11093.6 11267.0 12863.9 13160.2 13428.7 17920.3 20262.2 24532.0 25283.4 25405.2 7579.3 7820.1 7840.5 7849.5 7913.7 3225.7 3737.2 3804.6 3806.5 3813.5 3798.8 4300.1 4312.8 4462.0 4478.4 859.8 892.9 896.6 896.8 899.1 599.5 645.4 670.7 676.5 696.2 9443.9 10687.3 11555.5 11716.0 11851.2 650.6 653.6 660.8 667.6 689.3 5052.4 5366.8 5377.5 5503.7 5575.0 77524.6 82599.2 104558.5 105310.0 108359.3 90422.0 90872.0 91674.2 93451.5 94497.6 65326.0 70971.6 74794.0 84097.0 84287.9 8319.8 11086.7 11135.3 11310.0 11323.7 41357.0 42614.6 42708.0 43385.8 43999.7 54435.4 55100.0 56171.7 56274.4 56339.7 13575.9 13776.4 13958.9 13969.0 14042.4 17784.6 17984.7 18715.7 18809.9 18852.6 16439.8 16787.6 17229.4 17420.9 17552.6 16890.7 17024.7 17140.7 17336.7 17477.5 15554.3 15805.4 15919.7 16045.2 16155.1 11525.7 11675.4 11883.8 11937.5 11980.7 11805.9 12900.9 12993.4 13930.1 13949.6 17:02:21 INFO - PID 1628 | -------- Summary: end -------- 17:02:21 INFO - PID 1628 | 17:02:22 INFO - TEST-INFO | 1628: exit 0 17:02:22 INFO - TEST-OK | dromaeo_css | took 1118868ms 17:02:22 INFO - TEST-START | kraken 17:02:22 INFO - operating with platform_type : mac_ 17:02:22 INFO - Initialising browser for kraken test... 17:02:22 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpeX4bEK/profile http://localhost:49246/getInfo.html) 17:02:24 INFO - PID 1638 | __metrics Screen width/height:1600/1200 17:02:24 INFO - PID 1638 | colorDepth:24 17:02:24 INFO - PID 1638 | Browser inner width/height: 1024/689 17:02:24 INFO - PID 1638 | __metrics 17:02:24 INFO - PID 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:02:24 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:02:25 INFO - TEST-INFO | 1638: exit 0 17:02:25 INFO - Browser initialized. 17:02:25 INFO - Running cycle 1/1 for kraken test... 17:02:25 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpeX4bEK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:38 INFO - PID 1639 | RSS: Main: 242053120 17:02:38 INFO - PID 1639 | 17:02:40 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:41 INFO - PID 1639 | RSS: Main: 312520704 17:02:41 INFO - PID 1639 | 17:02:44 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 17:02:44 INFO - PID 1639 | RSS: Main: 293662720 17:02:44 INFO - PID 1639 | 17:02:48 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 17:02:49 INFO - PID 1639 | RSS: Main: 384847872 17:02:49 INFO - PID 1639 | 17:02:51 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 17:02:51 INFO - PID 1639 | RSS: Main: 289660928 17:02:51 INFO - PID 1639 | 17:02:53 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:54 INFO - PID 1639 | RSS: Main: 292163584 17:02:54 INFO - PID 1639 | 17:02:57 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:57 INFO - PID 1639 | RSS: Main: 356159488 17:02:57 INFO - PID 1639 | 17:03:00 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 17:03:01 INFO - PID 1639 | RSS: Main: 372568064 17:03:01 INFO - PID 1639 | 17:03:04 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 17:03:04 INFO - PID 1639 | RSS: Main: 378757120 17:03:04 INFO - PID 1639 | 17:03:06 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:06 INFO - PID 1639 | RSS: Main: 333393920 17:03:06 INFO - PID 1639 | 17:03:08 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:09 INFO - PID 1639 | RSS: Main: 332992512 17:03:09 INFO - PID 1639 | 17:03:11 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:12 INFO - PID 1639 | RSS: Main: 335585280 17:03:12 INFO - PID 1639 | 17:03:14 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:03:15 INFO - PID 1639 | RSS: Main: 335089664 17:03:15 INFO - PID 1639 | 17:03:18 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:19 INFO - PID 1639 | RSS: Main: 345358336 17:03:19 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 17:03:21 INFO - PID 1639 | RSS: Main: 388218880 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | __start_tp_report 17:03:21 INFO - PID 1639 | _x_x_mozilla_page_load 17:03:21 INFO - PID 1639 | _x_x_mozilla_page_load_details 17:03:21 INFO - PID 1639 | |i|pagename|runs| 17:03:21 INFO - PID 1639 | |0;ai-astar;110;110;108;110;109;113;108;110;118;162 17:03:21 INFO - PID 1639 | |1;audio-beat-detection;134;121;137;184;108;110;106;99;134;108 17:03:21 INFO - PID 1639 | |2;audio-dft;185;184;183;186;184;183;190;249;213;183 17:03:21 INFO - PID 1639 | |3;audio-fft;78;60;72;105;84;88;84;58;81;62 17:03:21 INFO - PID 1639 | |4;audio-oscillator;83;70;88;94;102;99;89;68;69;91 17:03:21 INFO - PID 1639 | |5;imaging-gaussian-blur;87;86;88;87;88;88;88;88;87;86 17:03:21 INFO - PID 1639 | |6;imaging-darkroom;94;95;94;95;95;95;94;95;94;101 17:03:21 INFO - PID 1639 | |7;imaging-desaturate;83;85;85;84;86;83;83;83;83;83 17:03:21 INFO - PID 1639 | |8;json-parse-financial;52;50;51;49;51;50;49;48;48;48 17:03:21 INFO - PID 1639 | |9;json-stringify-tinderbox;55;54;61;64;56;54;57;58;55;56 17:03:21 INFO - PID 1639 | |10;stanford-crypto-aes;84;83;83;83;82;81;83;80;80;81 17:03:21 INFO - PID 1639 | |11;stanford-crypto-ccm;134;139;150;134;137;136;139;138;180;154 17:03:21 INFO - PID 1639 | |12;stanford-crypto-pbkdf2;187;187;190;187;185;186;186;185;177;183 17:03:21 INFO - PID 1639 | |13;stanford-crypto-sha256-iterative;69;68;67;67;67;68;67;68;69;67 17:03:21 INFO - PID 1639 | __end_tp_report 17:03:21 INFO - PID 1639 | __start_cc_report 17:03:21 INFO - PID 1639 | _x_x_mozilla_cycle_collect,2167 17:03:21 INFO - PID 1639 | __end_cc_report 17:03:21 INFO - PID 1639 | __startTimestamp1493078601394__endTimestamp 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | ------- Summary: start ------- 17:03:21 INFO - PID 1639 | Number of tests: 14 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#0] ai-astar Cycles:10 Average:115.80 Median:110.00 stddev:16.50 (15.0%) stddev-sans-first:17.36 17:03:21 INFO - PID 1639 | Values: 110.0 110.0 108.0 110.0 109.0 113.0 108.0 110.0 118.0 162.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:134.00 stddev:25.02 (18.7%) stddev-sans-first:26.28 17:03:21 INFO - PID 1639 | Values: 134.0 121.0 137.0 184.0 108.0 110.0 106.0 99.0 134.0 108.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#2] audio-dft Cycles:10 Average:194.00 Median:185.50 stddev:21.37 (11.5%) stddev-sans-first:22.42 17:03:21 INFO - PID 1639 | Values: 185.0 184.0 183.0 186.0 184.0 183.0 190.0 249.0 213.0 183.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#3] audio-fft Cycles:10 Average:77.20 Median:79.50 stddev:14.60 (18.4%) stddev-sans-first:15.49 17:03:21 INFO - PID 1639 | Values: 78.0 60.0 72.0 105.0 84.0 88.0 84.0 58.0 81.0 62.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:88.50 stddev:12.47 (14.1%) stddev-sans-first:13.20 17:03:21 INFO - PID 1639 | Values: 83.0 70.0 88.0 94.0 102.0 99.0 89.0 68.0 69.0 91.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 17:03:21 INFO - PID 1639 | Values: 87.0 86.0 88.0 87.0 88.0 88.0 88.0 88.0 87.0 86.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:2.10 (2.2%) stddev-sans-first:2.18 17:03:21 INFO - PID 1639 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 101.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:83.50 stddev:1.14 (1.4%) stddev-sans-first:1.17 17:03:21 INFO - PID 1639 | Values: 83.0 85.0 85.0 84.0 86.0 83.0 83.0 83.0 83.0 83.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:50.00 stddev:1.43 (2.9%) stddev-sans-first:1.22 17:03:21 INFO - PID 1639 | Values: 52.0 50.0 51.0 49.0 51.0 50.0 49.0 48.0 48.0 48.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:56.50 stddev:3.23 (5.7%) stddev-sans-first:3.35 17:03:21 INFO - PID 1639 | Values: 55.0 54.0 61.0 64.0 56.0 54.0 57.0 58.0 55.0 56.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:1.41 (1.7%) stddev-sans-first:1.30 17:03:21 INFO - PID 1639 | Values: 84.0 83.0 83.0 83.0 82.0 81.0 83.0 80.0 80.0 81.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:139.00 stddev:14.26 (10.3%) stddev-sans-first:14.65 17:03:21 INFO - PID 1639 | Values: 134.0 139.0 150.0 134.0 137.0 136.0 139.0 138.0 180.0 154.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.30 Median:186.50 stddev:3.43 (1.8%) stddev-sans-first:3.59 17:03:21 INFO - PID 1639 | Values: 187.0 187.0 190.0 187.0 185.0 186.0 186.0 185.0 177.0 183.0 17:03:21 INFO - PID 1639 | 17:03:21 INFO - PID 1639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 17:03:21 INFO - PID 1639 | Values: 69.0 68.0 67.0 67.0 67.0 68.0 67.0 68.0 69.0 67.0 17:03:21 INFO - PID 1639 | -------- Summary: end -------- 17:03:21 INFO - PID 1639 | 17:03:22 INFO - TEST-INFO | 1639: exit 0 17:03:22 INFO - TEST-OK | kraken | took 60312ms 17:03:22 INFO - SUITE-END | took 1179s 17:03:22 INFO - Completed test suite (00:19:39) 17:03:22 INFO - javascript benchmark 17:03:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7695.762081902135, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3486.2156014896636, 3490.1274681329683, 3542.238418739971, 3551.3430015447143, 3572.4462708280207, 4929.964707411444, 5749.166370876221, 6001.699915004243, 6168.167297414853, 6192.814215573529, 5984.401559844025, 6035.305939816923, 6042.516598672107, 6047.818565443033, 6082.057281121422, 5208.322918020662, 5227.26818245446, 5227.503387178212, 5291.947080529184, 5299.735013249341, 3823.5029446171957, 5341.43914888935, 5346.786128554853, 5354.705491197982, 5480.972595137018, 5299.708516031616, 5339.759710813023, 5377.085895397772, 5386.111291636876, 5400.351957765074, 5390.568754499631, 5397.946020539784, 5403.621746477748, 5406.405295417501, 5411.134218525017, 5155.097857874857, 5237.423883372826, 5300.098983172831, 5313.3092697949405, 5407.0, 4404.581564751344, 5989.3711160327975, 6060.696965151725, 6084.117802918597, 6095.9695201524155, 6441.967790161066, 6444.838879028015, 6461.0, 6461.61230326182, 6467.579607325509, 6276.309605943343, 6555.868882622369, 6565.507586930951, 6582.3417658234275, 6588.374104460068, 6072.332043475214, 6080.635161890256, 6087.360827113178, 6092.543059270483, 6108.5418593605655, 6441.774537891151, 6463.870722585616, 6690.230623478362, 6729.22613899398, 6771.119754431892, 5319.414864364994, 6354.17395738551, 6392.296847346788, 6405.743770249138, 6412.61524308543, 6567.9671601641685, 6573.1783527059115, 6576.736930522821, 6580.407763301326, 6586.506012049115, 6247.219097612799, 6289.779857704958, 6376.521760867953, 6461.935380646228, 6469.547131700736, 6182.969085154636, 6452.161219041494, 6486.67566621667, 6489.902651460137, 6503.512236582275, 5200.063988482034, 5201.765920533585, 5205.479452054764, 5208.739563021833, 5239.842804715865, 4570.108828778356, 4585.610223131004, 4643.048175124091, 4654.6741728078705, 4681.110588988081, 6076.75692972285, 6159.599626024294, 6186.845328866814, 6189.102580125857, 6240.937590624127, 6568.113304703804, 6583.80248592543, 6586.077949087132, 6591.110200123018, 6607.471402287805, 6196.783112591128, 6202.100695399142, 6203.565750397429, 6207.068939659087, 6220.502359811204, 5505.724713764296, 5624.0, 5629.408912064257, 5660.518855897212, 5747.453991870766, 6739.52823302374, 6824.078749368771, 6833.384995350442, 6835.93164068353, 6838.897416538855, 6554.508411869224, 6570.737170513126, 6589.571677840925, 6611.33886611335, 6611.471082313307, 6494.383033611799, 6514.022896565553, 6711.194656641234, 6773.93226067733, 6796.76211332601, 6444.4844412445955, 6446.161998940108, 6450.935490645221, 6452.12896258999, 6456.515761317826, 5093.796248150033, 6293.118963345044, 6365.077063825812, 6581.901271481028, 6591.802245932629, 6229.127922091002, 6299.590526615939, 6333.018382150774, 6341.460975817107, 6345.96827015862, 6322.272938612118, 6349.333320001518, 6349.746010159542, 6361.300256971822, 6385.744570217139, 6147.938520614736, 6229.221347331583, 6235.532335074979, 6249.999999999978, 6315.652639104894, 6320.557560970872, 6359.20509936258, 6362.809115726535, 6363.331850155667, 6367.204099487564, 6270.15352927349, 6304.779332723516, 6313.873722525432, 6314.052892066226, 6322.178116844781], "value": 5934.608379300308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.9697212111516, 779.9532028078315, 794.3962588432792, 939.6053657463865, 994.4530508220477, 26773.732262677368, 37182.81408592957, 37461.25077498448, 37510.249795004085, 37580.43629345562, 39890.0, 40083.799581002124, 40118.0, 40124.99687507814, 40211.0, 6083.422074902877, 8465.91534084659, 8647.178518040808, 8653.48079115252, 8692.304615630766, 6219.689015549227, 6297.874042519147, 6331.873362532747, 6332.335104813974, 6343.207099112611, 8362.665493380258, 8547.145285471466, 8553.700620478285, 8564.528950907697, 8567.057623661392, 8503.659853605848, 8566.571671416466, 8595.570221488932, 8603.139686031409, 8614.05245423003, 8377.204165604318, 8454.112318206562, 8473.195046470575, 8478.872816907751, 8483.872741908875, 37615.059623509354, 37741.433878491844, 37777.0, 37796.81101594502, 37803.62196378056, 3572.499850020999, 3592.3892938200306, 3592.8203589820664, 3598.1544337080763, 3599.8380072896784, 24708.258752237463, 30888.0733577993, 30912.69087309143, 30919.381612367626, 30937.8453107733, 3132.0916934089087, 3177.094528059515, 3186.139742269574, 3192.521121831744, 3208.358328334319, 270502.0, 277732.0, 278180.0, 278237.0, 278587.0, 48755.75622121867, 48920.26619600709, 48943.5105648939, 48966.26550601672, 49008.0, 50639.746801265755, 50658.74670626697, 50677.493225068014, 50704.73238169075, 50748.49251507438, 13506.39221235027, 13599.0, 13599.456021759217, 13609.251491168081, 13627.931860340635, 11047.447627618587, 11078.169137314733, 11092.946170113826, 11104.611338603272, 11111.55553777856, 10911.290766100337, 10940.12479001678, 10953.17851161166, 12238.571649992386, 12581.245125292511, 5024.944761600105, 5157.484251574812, 5159.819406320836, 5174.43081261061, 5188.377394712583, 895.8835351404276, 988.5057471264367, 999.2505620784411, 1009.6819501856892, 1056.7886422715487, 20532.58934821295, 20600.38198854037, 21668.45828854291, 23861.880690596437, 24062.15782447606, 1098.1599076706325, 1109.4452773613193, 1135.0692432205676, 1143.74837535742, 1154.7921374152734, 11466.509353783955, 11823.349715765715, 12153.149279550347, 12200.572979945659, 12272.509099636092, 252982.0, 290505.0, 290783.54608226824, 290871.0, 291040.0, 53016.20475692867, 53027.93944121096, 53181.93636127333, 53336.73331633317, 53501.66245843885, 1440.3662388549005, 1475.4172102019643, 1516.3328135620513, 1521.9010764300285, 1540.8690261327688, 21831.781682182977, 23185.72478513698, 23331.533369332177, 23347.0, 23347.649785253576, 37778.0, 37875.0, 37903.0, 37969.810150949066, 37975.43036854504, 272008.0, 272327.0, 272567.2743272542, 273280.0, 273582.0, 33908.830455847565, 34002.14994625154, 34046.63813447434, 34088.65911340855, 34097.65902340945, 45267.64197074093, 45332.0, 45368.31947520856, 45386.77306613446, 45448.0, 29534.852325738233, 29916.0, 30197.7920883171, 31069.689303107585, 31310.373792523565, 30389.848050759603, 31024.22439439032, 31028.379432411675, 31138.688613114486, 31424.0, 36478.0, 36523.26953460969, 37129.257414852094, 37392.0, 37450.87647370583, 30047.549286760277, 30831.38337233198, 31222.531662025543, 31381.8430907844, 31445.213869653442, 21233.0, 22785.88607056954, 22886.084556618214, 24019.639705404083, 24392.146274880295], "value": 16964.86937134357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3466107617048, 425.8408885749049, 435.19271750902067, 439.7625282347532, 456.4935712149904, 17284.999999999985, 21029.894850525747, 21774.782252177494, 21792.346229613097, 22047.22834700786, 22192.0, 22732.20437284691, 23117.653235201484, 23152.0, 23467.0, 6142.600730952485, 6162.383761623847, 6182.72177752, 6210.65841378724, 6311.084892690557, 3691.741578089535, 3736.308782875177, 6137.294211165706, 6267.592606480587, 6278.183836101301, 5950.880982380349, 6195.659238741868, 6206.472449841769, 6230.28351739549, 6242.687865606701, 5891.322497912752, 6098.603590766586, 6200.503959683215, 6210.906836397435, 6211.90682139766, 5493.725313734337, 5493.972530137324, 5495.093309603911, 5496.5053145217125, 5497.45025497451, 27431.314217144532, 27781.0, 28324.00865969681, 28459.57310640342, 28655.85672071647, 1922.8365588924958, 2144.4424449643047, 2253.042456955787, 2255.2444930948154, 2257.266388423769, 17459.738103928452, 17624.383146589935, 18051.021581439178, 18164.0, 18277.451676449728, 2066.390414827614, 2151.95696086079, 2171.3160354488446, 2173.3914503938922, 2177.00946069538, 159025.0, 159938.20030899887, 160519.0, 161213.0, 166320.0, 10373.429461379546, 11376.0, 11694.649160525198, 12144.392780360946, 12382.75234495305, 13537.279243331039, 15946.122963237134, 16010.279537420844, 16293.918530407509, 16314.75527867083, 8619.103797164613, 8704.608292626846, 8789.560521974003, 8954.820903581893, 8975.057618950046, 8314.501129932223, 8326.958365208135, 8362.289205417608, 8477.152284771597, 8502.617382217815, 7550.7734767957045, 7667.386609071261, 7689.653965571562, 7697.268759467842, 7704.73033443838, 1857.9163937622839, 2108.820750236247, 2127.6383014887506, 2145.2277180215424, 2310.5905397707384, 842.6376658037103, 944.3436811416137, 951.3530799056708, 952.1668540027476, 957.2581249531669, 20930.0, 20990.160393584392, 21076.89461552713, 21123.471913202295, 21140.83725395118, 965.7979806042235, 992.1864071461476, 1012.5949620151998, 1012.7569383347943, 1028.3289654311743, 10593.09958653523, 10827.458627068616, 10830.67507974762, 10838.0, 10840.837387439195, 499431.50284248346, 554129.0, 565859.0, 571831.0, 578660.0, 128226.35886820692, 128824.0, 130425.0, 133438.0, 136600.31699841438, 1164.889335513125, 1174.4186627619383, 1232.6856651553976, 1247.52594014274, 1248.5942068827485, 20091.69403988736, 20840.0, 21077.0, 21253.46866328292, 21256.893715531325, 57582.84834303207, 58414.7079264601, 58582.707086464296, 58864.70567647134, 59371.515712107546, 79449.60275198588, 79466.41067178508, 80513.0, 80795.59602201951, 82023.5898820502, 8680.565971701515, 8758.299336053227, 8762.283692055484, 8793.956030219808, 8900.643974240958, 13702.93148534251, 13753.38109785082, 14010.859891400956, 14061.789073164115, 14121.858781412055, 11202.0, 11469.942650286695, 11716.41417929083, 11973.461194246105, 12066.879331206927, 10913.39976301311, 11129.276597021168, 11153.83269250978, 11449.484773185393, 11481.024112950492, 10168.186545076524, 11377.0, 11474.713132171762, 11702.473388697359, 11921.0, 6710.530262881552, 8440.0, 8623.353248506262, 8782.516961567175, 8950.68672596456, 10046.8492972604, 11209.831852522055, 11407.030402415887, 11736.295822250693, 11936.343501107522], "value": 10357.473992286297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.6145559971008, 1449.768037114062, 1477.3204326010034, 1479.0534058202745, 1480.962975925601, 11252.324860508365, 11839.408029598519, 11856.940715296421, 11871.940640296787, 11885.405729713522, 11475.311481311128, 11852.111091668115, 11855.7628847423, 11863.110266729987, 11867.0, 2509.1845150326126, 2546.8726563671835, 2548.4903019396197, 2556.9360765980905, 2559.8848051837617, 2104.705341252226, 2166.5558560495137, 2400.2079313826393, 2532.278300684305, 2534.733852945442, 2154.482924098221, 2186.4861757487056, 2187.387531491185, 2187.9343619691354, 2189.8357623178326, 2387.510560335127, 2452.3256104571205, 2455.5579995600783, 2456.054419048661, 2457.496213276283, 2328.6157783965627, 2363.61000434928, 2369.5734767741974, 2370.573296806574, 2380.9166679166146, 11519.827202591969, 11800.645980620595, 11807.763844723144, 11833.585824496102, 11858.46636901333, 6523.18460192476, 6782.932170678279, 6785.491088168358, 6791.728330866808, 6815.386615204656, 3981.223661386031, 4290.806913688892, 4382.474103107647, 4382.474103107647, 4389.0, 1225.5281716539196, 1248.8938440232591, 1297.4420998970438, 1297.6236891301512, 1298.3183828490023, 16461.176941152895, 16593.66812663752, 16604.0, 16618.916905415397, 16633.584160395843, 5343.251944727741, 5493.450654934474, 5740.6268592541355, 5751.396103409165, 5756.30924289088, 12322.137450378388, 12342.259464432163, 12343.938280308721, 12345.197562158432, 12345.93827030859, 6606.867862642816, 6617.43751781104, 6617.569857959217, 6619.966900165468, 6629.171353580802, 5980.611260268069, 6126.111713801474, 6169.259688837278, 6255.56211065221, 6260.593061450991, 4204.498323497514, 4329.155814616182, 4369.453818272716, 4383.715058521186, 4401.097774956126, 1256.4220458589152, 1270.917390369623, 1279.1557572002434, 1293.5213970830853, 1331.6937104466026, 700.9474289428314, 761.4137114421865, 793.0998316910233, 814.8003739083962, 819.6762278899802, 5907.232059832194, 5961.761529538857, 6086.6348019119, 6332.873342533124, 6344.429001389804, 918.2791508665799, 922.423485321674, 946.4557879219476, 969.5249327829313, 981.617169303972, 3224.85517641234, 3236.4983427568295, 3415.2848485454124, 3909.179072394829, 3928.744631598994, 14555.92722036383, 15191.94908687313, 15197.240137993056, 15209.163496007826, 15249.847501525064, 14508.854911450962, 14888.330025148894, 15201.011934224462, 15226.0, 15250.771238431433, 8413.747587572383, 8530.658773648984, 8594.613242403982, 8699.434536755218, 8700.12998700125, 6578.868422631616, 6762.8647427052165, 6796.0, 6809.931900681128, 6812.352826481674, 13298.468061277441, 13398.397072131582, 13492.190468571916, 13516.459341626225, 13552.93223533876, 13700.109492882932, 13742.93128534391, 13749.968752343415, 13833.584992450242, 14105.6473588157, 8558.743237702878, 8730.0, 8736.039035706195, 8736.519491428033, 8764.868526971974, 8383.874241886499, 9767.511624418608, 9919.15687166599, 10099.899001009895, 10126.44304563256, 9058.90941090607, 9081.954590227007, 9111.635534578543, 9120.084782195812, 9213.723588292361, 7217.350438460564, 8882.955585222033, 8932.687355942511, 9040.0, 9098.454092754457, 8122.918770812453, 8245.752627421187, 8248.298894594027, 8250.051244107004, 8257.545834979133, 4784.40194975628, 5602.439756024365, 6011.849703757266, 6149.84625384369, 6220.7511699531515, 6057.121717351048, 6202.162708034358, 6213.720382582705, 6237.220347456568, 6378.6810659467765], "value": 5314.6390438315475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.88017154767795, 399.8820347997341, 404.93483235498957, 406.1106177471336, 411.21458015190973, 5822.6215296005785, 5861.76552937883, 5870.559708021894, 5882.6764527950945, 5890.64656120633, 4985.476524964881, 5583.469570390806, 5664.150377443386, 5693.743781529831, 5740.56945729071, 3635.781853088823, 3756.2299728555718, 4413.61664701061, 4418.690691651585, 4431.955680443195, 3747.7376583639157, 4435.832255422429, 4451.710638808483, 4452.97773511132, 4454.777261136946, 3786.469894214812, 4197.391378250152, 4341.934870976938, 4405.625521830648, 4408.647308215335, 4363.759993200372, 4368.563143685606, 4389.582989615981, 4404.845830395937, 4406.801693923749, 3409.5056216848666, 3886.805659717003, 3900.6294402031763, 3901.0247438140464, 3909.4331321958443, 4320.1143765527995, 5036.798528058874, 5383.380911195223, 5534.252875861747, 5588.066265210756, 4827.686200396963, 4872.317875497433, 5285.7885684572575, 5291.682499050069, 5298.523132918056, 4890.755462226874, 6111.96944015277, 6128.509719222451, 6144.96927515364, 6154.907676384858, 3781.640744129303, 4071.918561628751, 4458.152950939344, 4460.0, 4467.687261891669, 5287.391949925769, 5866.648001119904, 6273.498120150377, 6409.391107844747, 6475.449586785129, 4135.379693046068, 4206.730168878591, 4495.842645507391, 4617.145828021827, 4632.170292734419, 3871.399933010388, 3901.8244179012013, 4708.858734237979, 4717.976410117927, 4733.219018861918, 4116.197341518435, 4465.88352911772, 4798.688085274446, 5046.873828154326, 5333.893112220651, 5693.718913244486, 5854.824355269348, 5905.793297234576, 6155.599886007395, 6162.568620196633, 1551.612096975756, 1552.4954389823354, 1556.789833372503, 1574.5748647865241, 1604.7271963766188, 1096.6381094238882, 1100.6863044032411, 1115.726646971481, 1116.2465335898237, 1133.5465813674596, 5825.951328760779, 5858.121281807677, 5869.677167755729, 5870.295564532198, 5874.148248504029, 5391.7034563099405, 5508.14623733322, 6032.788852390146, 6404.807855764335, 6408.903866442007, 5547.77808887648, 5687.488126068591, 5836.503897168704, 5859.882802344015, 5876.206712093898, 2770.459760346713, 3188.7767856250302, 3267.2648654053123, 3331.800091994488, 3338.415777239022, 5564.860878478071, 6587.703553340111, 6611.760237483694, 6633.6019838809825, 6635.288944849115, 5662.518685911661, 5883.61756485827, 6558.606483610999, 6572.80281591553, 6585.407313341726, 5857.062869940789, 5917.260342457193, 6142.58100285203, 6168.920438923171, 6501.804945851632, 5240.921386179287, 5964.135200396005, 6049.606775559574, 6327.493800496041, 6345.17512723343, 6041.214642096499, 6252.781152659635, 6259.216123404808, 6263.874722505616, 6280.528960328085, 5346.572274218131, 6159.507239420746, 6479.0, 6486.5459417842185, 6488.513361497812, 4241.575842415858, 4257.361395790656, 4265.9761657201425, 4276.166147601312, 4320.2655548556195, 6136.110264011782, 6366.554341196072, 6403.423691867754, 6416.486681065597, 6419.390157934989, 5886.3525012247765, 6197.876042479035, 6205.689715514297, 6232.348427666581, 6247.437730604267, 5767.84643071379, 6008.819735407945, 6204.7828326008375, 6215.564910456224, 6234.2830574482705, 5750.913736294043, 5822.176244521488, 6091.878162436815, 6095.481884039907, 6128.142060111677, 6231.158793562811, 6234.407731265523, 6236.75052997875, 6239.937600623935, 6270.2475702915945, 5133.204353325241, 5563.944360556343, 5636.098224284095, 5763.510101641407, 5931.673757943355], "value": 4548.955838732276, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1316324339437, 807.1363640904235, 825.088277453414, 839.4711331860926, 864.6238886084552, 13019.34903254837, 17703.203355848986, 17974.460766177002, 18315.0, 18395.172217250223, 16621.66756664866, 16792.412265570707, 17254.137293135325, 17277.481675549723, 17533.473995780147, 913.9086091390841, 936.180841763457, 938.995305023474, 939.6570251858057, 940.0975063938627, 675.5237557521936, 689.3554526517722, 946.2051876423802, 977.6529332087114, 992.1120597065621, 1037.424229552598, 1039.9756240103493, 1040.0795296162876, 1040.8907064758205, 1042.8696412948382, 1012.3065699995526, 1014.7919676466344, 1017.3946501831399, 1020.0870221152102, 1023.7542989682497, 754.3587950242305, 755.1165136789969, 755.3466251692302, 756.4213376766778, 761.8476304739074, 15843.841561584351, 16247.943883647526, 16367.0, 16381.754273685905, 16655.583610409714, 16066.116363599996, 16231.83768162315, 16300.184990750533, 16468.917655411766, 16556.42052528168, 15476.76784848228, 15613.765793513106, 15665.451709190123, 15785.210739463097, 15851.27495038665, 5255.211718242256, 5283.603729720248, 5283.788648454096, 5286.444923283077, 5294.814681486168, 89657.0, 94442.0, 123158.87813313717, 125415.37292313571, 130643.20175986744, 11093.611723589796, 11267.0, 12863.871361286454, 13160.210387376788, 13428.664283392798, 17920.283188672307, 20262.189512419634, 24532.0, 25283.367915801886, 25405.237842864743, 7579.279968402993, 7820.139784623687, 7840.490368126054, 7849.450538462367, 7913.723019694283, 3225.741940644743, 3737.1965027519213, 3804.5814960354337, 3806.5241844769403, 3813.5423749149722, 3798.753081049723, 4300.1399720056115, 4312.849050283225, 4461.955380446219, 4478.395416618715, 859.7678626770737, 892.8660700894787, 896.587569717924, 896.8475359188823, 899.1053901368181, 599.5293694449836, 645.3578689204272, 670.731707317077, 676.546713701821, 696.1576492444098, 9443.905560944302, 10687.305325153995, 11555.480003399867, 11716.0, 11851.22967007159, 650.5933791380387, 653.5849735418044, 660.7984564707714, 667.576089183372, 689.290031267795, 5052.368453943257, 5366.838994830161, 5377.5429088527135, 5503.669779813224, 5574.972125139429, 77524.61237693776, 82599.17400825914, 104558.47720761347, 105310.0, 108359.30632142484, 90422.0, 90872.0, 91674.1665166693, 93451.53274233585, 94497.58253626201, 65326.0, 70971.64514177499, 74794.0, 84097.0, 84287.8928026792, 8319.792005199919, 11086.667399978014, 11135.276207046516, 11309.982101610894, 11323.660290191307, 41357.0, 42614.57385426106, 42708.0, 43385.78307108444, 43999.68000959976, 54435.366938991894, 55100.0, 56171.71914140403, 56274.43725562856, 56339.71830140823, 13575.93212033973, 13776.380062896993, 13958.860411395755, 13969.022168448111, 14042.438302467786, 17784.644307113525, 17984.730229046312, 18715.719264210777, 18809.90595047016, 18852.622947540698, 16439.753403698716, 16787.58031049185, 17229.39697110595, 17420.912895435442, 17552.648947020734, 16890.74663880018, 17024.74462883033, 17140.742888856428, 17336.739948901028, 17477.475675729747, 15554.300056497712, 15805.36778528846, 15919.68160636804, 16045.19774011318, 16155.111468868854, 11525.654230373102, 11675.416229188337, 11883.821742673694, 11937.46281417321, 11980.700482488008, 11805.940970295094, 12900.870991289967, 12993.350332483149, 13930.094543854617, 13949.58151255464], "value": 8239.405253987854, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 108.0, 110.0, 109.0, 113.0, 108.0, 110.0, 118.0, 162.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 121.0, 137.0, 184.0, 108.0, 110.0, 106.0, 99.0, 134.0, 108.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 183.0, 186.0, 184.0, 183.0, 190.0, 249.0, 213.0, 183.0], "value": 194.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 72.0, 105.0, 84.0, 88.0, 84.0, 58.0, 81.0, 62.0], "value": 77.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 88.0, 94.0, 102.0, 99.0, 89.0, 68.0, 69.0, 91.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 87.0, 88.0, 88.0, 88.0, 88.0, 87.0, 86.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 101.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 84.0, 86.0, 83.0, 83.0, 83.0, 83.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 49.0, 51.0, 50.0, 49.0, 48.0, 48.0, 48.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 61.0, 64.0, 56.0, 54.0, 57.0, 58.0, 55.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 82.0, 81.0, 83.0, 80.0, 80.0, 81.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 150.0, 134.0, 137.0, 136.0, 139.0, 138.0, 180.0, 154.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 190.0, 187.0, 185.0, 186.0, 186.0, 185.0, 177.0, 183.0], "value": 185.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 67.0], "value": 67.7, "unit": "score"}]}]} 17:03:22 INFO - Return code: 0 17:03:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:03:22 ERROR - # TBPL SUCCESS # 17:03:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:03:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:03:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:03:22 INFO - 2017-04-24 17:03:22.770 screenresolution[1643:10026] starting screenresolution argv=screenresolution get 17:03:22 INFO - 2017-04-24 17:03:22.775 screenresolution[1643:10026] Display 0: 1600x1200x32@60 17:03:22 INFO - 2017-04-24 17:03:22.781 screenresolution[1644:10029] starting screenresolution argv=screenresolution list 17:03:22 INFO - Available Modes on Display 0 17:03:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:03:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:03:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:03:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:03:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:03:23 INFO - Intel Iris: 17:03:23 INFO - Chipset Model: Intel Iris 17:03:23 INFO - Type: GPU 17:03:23 INFO - Bus: Built-In 17:03:23 INFO - VRAM (Dynamic, Max): 1536 MB 17:03:23 INFO - Vendor: Intel (0x8086) 17:03:23 INFO - Device ID: 0x0a2e 17:03:23 INFO - Revision ID: 0x0009 17:03:23 INFO - Displays: 17:03:23 INFO - Display: 17:03:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:03:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:03:23 INFO - Display Serial Number: 1600x1200 60 17:03:23 INFO - Main Display: Yes 17:03:23 INFO - Mirror: Off 17:03:23 INFO - Online: Yes 17:03:23 INFO - Rotation: Supported 17:03:23 INFO - Return code: 0 17:03:23 INFO - Running post-action listener: _resource_record_post_action 17:03:23 INFO - [mozharness: 2017-04-25 00:03:23.034456Z] Finished run-tests step (success) 17:03:23 INFO - Running post-run listener: _resource_record_post_run 17:03:23 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 38343680; Write bytes: 509545472; Read time: 245; Write time: 1570 17:03:23 INFO - TinderboxPrint: CPU usage
53.3% 17:03:23 INFO - TinderboxPrint: I/O read bytes / time
38,343,680 / 245 17:03:23 INFO - TinderboxPrint: I/O write bytes / time
509,545,472 / 1,570 17:03:23 INFO - TinderboxPrint: CPU idle
2,239.8 (46.7%) 17:03:23 INFO - TinderboxPrint: CPU system
954.9 (19.9%) 17:03:23 INFO - TinderboxPrint: CPU user
1,603.0 (33.4%) 17:03:23 INFO - TinderboxPrint: Swap in / out
246,235,136 / 0 17:03:23 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196747776; Write bytes: 195053056; Read time: 14853; Write time: 426 17:03:23 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 37368832; Write bytes: 297670144; Read time: 230; Write time: 1093 17:03:23 INFO - Running post-run listener: _upload_blobber_files 17:03:23 INFO - Blob upload gear active. 17:03:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:03:23 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 17:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:03:23 INFO - (blobuploader) - INFO - Open directory for files ... 17:03:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:03:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:03:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:25 INFO - (blobuploader) - INFO - Done attempting. 17:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:26 INFO - (blobuploader) - INFO - Done attempting. 17:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:27 INFO - (blobuploader) - INFO - Done attempting. 17:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:03:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:29 INFO - (blobuploader) - INFO - Done attempting. 17:03:29 INFO - (blobuploader) - INFO - Iteration through files over. 17:03:29 INFO - Return code: 0 17:03:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:03:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:03:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899e65077d051462e3716ffe88287b018a543b949bed256558b1eadb9aec175198788bf99b33c95d983a114b0baba8624bb25e733d246808d7f695911f005abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ce4275d54dbf4b294ae86c485c3e1a926e1e7716a04ae35c7eec128c344a20077ef6eaabf82f187535cf0c0d39ef3c58181906ee4823599931750a9584a93af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ff75dfbe9017b9482c3ea8a6c485919558d1978e0247be32c7bbed657a4ee178c6d4c85e7b41db0410c1d8814396ba81f99ff9f42e76c9d19ff04da85a628", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e70db7301a78c5f9ebbb3995bb416bb45222a0527012b7d76d34a3f6a819ba8ee3065f022149791f3a9d3cea0c6af86d344bfaac6a3eed673c805014ffaec031"} 17:03:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:03:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:03:29 INFO - Contents: 17:03:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899e65077d051462e3716ffe88287b018a543b949bed256558b1eadb9aec175198788bf99b33c95d983a114b0baba8624bb25e733d246808d7f695911f005abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ce4275d54dbf4b294ae86c485c3e1a926e1e7716a04ae35c7eec128c344a20077ef6eaabf82f187535cf0c0d39ef3c58181906ee4823599931750a9584a93af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ff75dfbe9017b9482c3ea8a6c485919558d1978e0247be32c7bbed657a4ee178c6d4c85e7b41db0410c1d8814396ba81f99ff9f42e76c9d19ff04da85a628", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e70db7301a78c5f9ebbb3995bb416bb45222a0527012b7d76d34a3f6a819ba8ee3065f022149791f3a9d3cea0c6af86d344bfaac6a3eed673c805014ffaec031"} 17:03:29 INFO - Running post-run listener: copy_logs_to_upload_dir 17:03:29 INFO - Copying logs to upload dir... 17:03:29 INFO - mkdir: /builds/slave/test/build/upload/logs 17:03:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.645408 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-24 17:03:29.432320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:29.435575) ========= 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.Ej859Mzh6S/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.lOtWgKhIte/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899e65077d051462e3716ffe88287b018a543b949bed256558b1eadb9aec175198788bf99b33c95d983a114b0baba8624bb25e733d246808d7f695911f005abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ce4275d54dbf4b294ae86c485c3e1a926e1e7716a04ae35c7eec128c344a20077ef6eaabf82f187535cf0c0d39ef3c58181906ee4823599931750a9584a93af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ff75dfbe9017b9482c3ea8a6c485919558d1978e0247be32c7bbed657a4ee178c6d4c85e7b41db0410c1d8814396ba81f99ff9f42e76c9d19ff04da85a628", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e70db7301a78c5f9ebbb3995bb416bb45222a0527012b7d76d34a3f6a819ba8ee3065f022149791f3a9d3cea0c6af86d344bfaac6a3eed673c805014ffaec031"} build_url:https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010567 build_url: 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899e65077d051462e3716ffe88287b018a543b949bed256558b1eadb9aec175198788bf99b33c95d983a114b0baba8624bb25e733d246808d7f695911f005abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ce4275d54dbf4b294ae86c485c3e1a926e1e7716a04ae35c7eec128c344a20077ef6eaabf82f187535cf0c0d39ef3c58181906ee4823599931750a9584a93af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ff75dfbe9017b9482c3ea8a6c485919558d1978e0247be32c7bbed657a4ee178c6d4c85e7b41db0410c1d8814396ba81f99ff9f42e76c9d19ff04da85a628", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e70db7301a78c5f9ebbb3995bb416bb45222a0527012b7d76d34a3f6a819ba8ee3065f022149791f3a9d3cea0c6af86d344bfaac6a3eed673c805014ffaec031"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:29.470176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:29.470502) ========= 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.Ej859Mzh6S/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.lOtWgKhIte/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.005060 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:29.521117) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 17:03:29.521464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 17:03:29.521777) ========= ========= Total master_lag: 0.20 =========