builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0001 starttime: 1488198287.64 results: success (0) buildid: 20170227030203 builduid: 2f35ac8208f74c74814476464f0c4fc0 revision: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:47.643987) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:47.644430) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:47.644699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:47.671333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:47.671663) ========= 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.IEFttHDA6d/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.9bgTrhYySD/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-27 04:24:47-- 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% 16.0M=0.001s 2017-02-27 04:24:48 (16.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.642322 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:48.344914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:48.345242) ========= 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.IEFttHDA6d/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.9bgTrhYySD/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.027630 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:48.414898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 04:24:48.415268) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed --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 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IEFttHDA6d/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.9bgTrhYySD/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-27 04:24:48,519 truncating revision to first 12 chars 2017-02-27 04:24:48,519 Setting DEBUG logging. 2017-02-27 04:24:48,520 attempt 1/10 2017-02-27 04:24:48,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ef1e9abd296?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 04:24:49,660 unpacking tar archive at: mozilla-central-7ef1e9abd296/testing/mozharness/ program finished with exit code 0 elapsedTime=1.406537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 04:24:49.845799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:49.846195) ========= script_repo_revision: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:49.846590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:49.846859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 04:24:49.866613) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-27 04:24:49.866889) ========= /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.IEFttHDA6d/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.9bgTrhYySD/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:24:50 INFO - MultiFileLogger online at 20170227 04:24:50 in /builds/slave/test 04:24:50 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 04:24:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:50 INFO - {'append_to_log': False, 04:24:50 INFO - 'base_work_dir': '/builds/slave/test', 04:24:50 INFO - 'blob_upload_branch': 'Firefox', 04:24:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:50 INFO - 'branch': 'Firefox', 04:24:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:50 INFO - 'config_files': ('talos/mac_config.py',), 04:24:50 INFO - 'default_actions': ('clobber', 04:24:50 INFO - 'read-buildbot-config', 04:24:50 INFO - 'download-and-extract', 04:24:50 INFO - 'populate-webroot', 04:24:50 INFO - 'create-virtualenv', 04:24:50 INFO - 'install', 04:24:50 INFO - 'run-tests'), 04:24:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:50 INFO - 'download_minidump_stackwalk': True, 04:24:50 INFO - 'download_symbols': 'ondemand', 04:24:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:50 INFO - 'gecko_profile': False, 04:24:50 INFO - 'gecko_profile_interval': 0, 04:24:50 INFO - 'installer_path': 'installer.exe', 04:24:50 INFO - 'log_level': 'info', 04:24:50 INFO - 'log_name': 'talos', 04:24:50 INFO - 'log_to_console': True, 04:24:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:24:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:24:50 INFO - 'opt_config_files': (), 04:24:50 INFO - 'pip_index': False, 04:24:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:24:50 INFO - 'cmd': ('bash', 04:24:50 INFO - '-c', 04:24:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:24:50 INFO - 'enabled': True, 04:24:50 INFO - 'halt_on_failure': False, 04:24:50 INFO - 'name': 'check_screen_resolution'},), 04:24:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:24:50 INFO - 'cmd': ('bash', 04:24:50 INFO - '-c', 04:24:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:24:50 INFO - 'enabled': True, 04:24:50 INFO - 'halt_on_failure': False, 04:24:50 INFO - 'name': 'check_screen_resolution'},), 04:24:50 INFO - 'run_cmd_checks_enabled': True, 04:24:50 INFO - 'suite': 'dromaeojs', 04:24:50 INFO - 'system_bits': '32', 04:24:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:50 INFO - 'title': 't-yosemite-r7-0001', 04:24:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:50 INFO - 'use_talos_json': True, 04:24:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:50 INFO - 'work_dir': 'build'} 04:24:50 INFO - [mozharness: 2017-02-27 12:24:50.092341Z] Running clobber step. 04:24:50 INFO - Running pre-action listener: _resource_record_pre_action 04:24:50 INFO - Running main action method: clobber 04:24:50 INFO - rmtree: /builds/slave/test/build 04:24:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:52 INFO - Running post-action listener: _resource_record_post_action 04:24:52 INFO - [mozharness: 2017-02-27 12:24:52.742785Z] Finished clobber step (success) 04:24:52 INFO - [mozharness: 2017-02-27 12:24:52.742920Z] Running read-buildbot-config step. 04:24:52 INFO - Running pre-action listener: _resource_record_pre_action 04:24:52 INFO - Running main action method: read_buildbot_config 04:24:52 INFO - Using buildbot properties: 04:24:52 INFO - { 04:24:52 INFO - "project": "", 04:24:52 INFO - "product": "firefox", 04:24:52 INFO - "script_repo_revision": "production", 04:24:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:24:52 INFO - "repository": "", 04:24:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:24:52 INFO - "buildid": "20170227030203", 04:24:52 INFO - "stage_platform": "macosx64", 04:24:52 INFO - "basedir": "/builds/slave/test", 04:24:52 INFO - "nightly_build": "True", 04:24:52 INFO - "buildnumber": 59, 04:24:52 INFO - "slavename": "t-yosemite-r7-0001", 04:24:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:24:52 INFO - "platform": "yosemite_r7", 04:24:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:24:52 INFO - "branch": "mozilla-central", 04:24:52 INFO - "repo_path": "mozilla-central", 04:24:52 INFO - "revision": "7ef1e9abd296a8edc39b7efc8d637767ba2f77ed", 04:24:52 INFO - "pgo_build": "False", 04:24:52 INFO - "builduid": "2f35ac8208f74c74814476464f0c4fc0", 04:24:52 INFO - "slavebuilddir": "test" 04:24:52 INFO - } 04:24:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:24:52 INFO - Running post-action listener: _resource_record_post_action 04:24:52 INFO - [mozharness: 2017-02-27 12:24:52.746380Z] Finished read-buildbot-config step (success) 04:24:52 INFO - [mozharness: 2017-02-27 12:24:52.746509Z] Running download-and-extract step. 04:24:52 INFO - Running pre-action listener: _resource_record_pre_action 04:24:52 INFO - Running main action method: download_and_extract 04:24:52 INFO - mkdir: /builds/slave/test/build/tests 04:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:52 INFO - trying https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:24:52 INFO - Downloading https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:24:53 INFO - Downloaded 1199 bytes. 04:24:53 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:24:53 INFO - Using the following test package requirements: 04:24:53 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:24:53 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:24:53 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:24:53 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'jsshell-mac.zip'], 04:24:53 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:24:53 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:24:53 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:24:53 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:24:53 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:24:53 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:24:53 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:24:53 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:24:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:24:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:24:53 INFO - Fetch https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:24:55 INFO - Expected file size: 51745277 04:24:55 INFO - Obtained file size: 51745277 04:25:11 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:25:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:25:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:11 INFO - Fetch https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:25:12 INFO - Expected file size: 51745277 04:25:12 INFO - Obtained file size: 51745277 04:25:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:25:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:25:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:25:28 INFO - Expected file size: 14404421 04:25:28 INFO - Obtained file size: 14404421 04:25:29 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')]} 04:25:29 INFO - trying https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:25:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:25:31 INFO - Downloaded 75056717 bytes. 04:25:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:25:31 INFO - mkdir: /builds/slave/test/properties 04:25:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:31 INFO - Contents: 04:25:31 INFO - build_url:https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:25:32 INFO - Running post-action listener: _resource_record_post_action 04:25:32 INFO - Running post-action listener: set_extra_try_arguments 04:25:32 INFO - [mozharness: 2017-02-27 12:25:32.357787Z] Finished download-and-extract step (success) 04:25:32 INFO - [mozharness: 2017-02-27 12:25:32.357910Z] Running populate-webroot step. 04:25:32 INFO - Running pre-action listener: _resource_record_pre_action 04:25:32 INFO - Running main action method: populate_webroot 04:25:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:32 INFO - '--tppagecycles', 04:25:32 INFO - '7'], 04:25:32 INFO - 'tests': ['tsvgm']}}, 04:25:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:25:32 INFO - 'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:25:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:25:32 INFO - 'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['damp', 'tps']}, 04:25:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:25:32 INFO - 'tests': ['damp', 'tps']}, 04:25:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['dromaeo_dom']}, 04:25:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['basic_compositor_video']}, 04:25:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['a11yr', 04:25:32 INFO - 'ts_paint', 04:25:32 INFO - 'tpaint', 04:25:32 INFO - 'sessionrestore', 04:25:32 INFO - 'sessionrestore_no_auto_restore', 04:25:32 INFO - 'tabpaint']}, 04:25:32 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:32 INFO - 'ts_paint', 04:25:32 INFO - 'tpaint', 04:25:32 INFO - 'sessionrestore', 04:25:32 INFO - 'sessionrestore_no_auto_restore', 04:25:32 INFO - 'tabpaint']}, 04:25:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:32 INFO - 'ts_paint', 04:25:32 INFO - 'tpaint', 04:25:32 INFO - 'sessionrestore', 04:25:32 INFO - 'sessionrestore_no_auto_restore', 04:25:32 INFO - 'tabpaint']}, 04:25:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:32 INFO - 'ts_paint', 04:25:32 INFO - 'tpaint', 04:25:32 INFO - 'sessionrestore', 04:25:32 INFO - 'sessionrestore_no_auto_restore', 04:25:32 INFO - 'tabpaint']}, 04:25:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['a11yr', 04:25:32 INFO - 'ts_paint', 04:25:32 INFO - 'tpaint', 04:25:32 INFO - 'sessionrestore', 04:25:32 INFO - 'sessionrestore_no_auto_restore', 04:25:32 INFO - 'tabpaint']}, 04:25:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['a11yr', 04:25:32 INFO - 'ts_paint', 04:25:32 INFO - 'tpaint', 04:25:32 INFO - 'sessionrestore', 04:25:32 INFO - 'sessionrestore_no_auto_restore', 04:25:32 INFO - 'tabpaint']}, 04:25:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['tsvgx', 04:25:32 INFO - 'tsvgr_opacity', 04:25:32 INFO - 'tart', 04:25:32 INFO - 'tscrollx', 04:25:32 INFO - 'cart', 04:25:32 INFO - 'tsvg_static']}, 04:25:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:32 INFO - 'tsvgr_opacity', 04:25:32 INFO - 'tart', 04:25:32 INFO - 'tscrollx', 04:25:32 INFO - 'cart', 04:25:32 INFO - 'tsvg_static']}, 04:25:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:25:32 INFO - 'talos_options': ['--disable-e10s'], 04:25:32 INFO - 'tests': ['tp5o']}, 04:25:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:25:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:25:32 INFO - 'talos_options': ['--disable-e10s', 04:25:32 INFO - '--xperf_path', 04:25:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:32 INFO - 'tests': ['tp5n']}, 04:25:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:25:32 INFO - 'talos_options': ['--xperf_path', 04:25:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:32 INFO - 'tests': ['tp5n']}}, 04:25:32 INFO - 'talos.zip': {'path': '', 04:25:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:32 INFO - Running post-action listener: _resource_record_post_action 04:25:32 INFO - [mozharness: 2017-02-27 12:25:32.376383Z] Finished populate-webroot step (success) 04:25:32 INFO - [mozharness: 2017-02-27 12:25:32.376517Z] Running create-virtualenv step. 04:25:32 INFO - Running pre-action listener: _resource_record_pre_action 04:25:32 INFO - Running main action method: create_virtualenv 04:25:32 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:32 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 04:25:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:32 INFO - Using real prefix '/tools/python27' 04:25:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:36 INFO - Installing pip.................done. 04:25:36 INFO - Return code: 0 04:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:36 INFO - Reading from file tmpfile_stdout 04:25:36 INFO - Output received: 04:25:36 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) 04:25:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:25:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:36 INFO - 'HOME': '/Users/cltbld', 04:25:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:36 INFO - 'LOGNAME': 'cltbld', 04:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:36 INFO - 'MOZ_NO_REMOTE': '1', 04:25:36 INFO - 'NO_EM_RESTART': '1', 04:25:36 INFO - 'PAGER': '/bin/cat', 04:25:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:36 INFO - 'PWD': '/builds/slave/test', 04:25:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:36 INFO - 'SHELL': '/bin/bash', 04:25:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:36 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:36 INFO - 'USER': 'cltbld', 04:25:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:36 INFO - 'XPC_FLAGS': '0x0', 04:25:36 INFO - 'XPC_SERVICE_NAME': '0', 04:25:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:36 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 04:25:36 INFO - Cleaning up... 04:25:36 INFO - Return code: 0 04:25:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:25:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:36 INFO - 'HOME': '/Users/cltbld', 04:25:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:36 INFO - 'LOGNAME': 'cltbld', 04:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:36 INFO - 'MOZ_NO_REMOTE': '1', 04:25:36 INFO - 'NO_EM_RESTART': '1', 04:25:36 INFO - 'PAGER': '/bin/cat', 04:25:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:36 INFO - 'PWD': '/builds/slave/test', 04:25:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:36 INFO - 'SHELL': '/bin/bash', 04:25:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:36 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:36 INFO - 'USER': 'cltbld', 04:25:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:36 INFO - 'XPC_FLAGS': '0x0', 04:25:36 INFO - 'XPC_SERVICE_NAME': '0', 04:25:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:36 INFO - Downloading/unpacking psutil>=3.1.1 04:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:40 INFO - Installing collected packages: psutil 04:25:40 INFO - Running setup.py install for psutil 04:25:40 INFO - building 'psutil._psutil_osx' extension 04:25:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:25:41 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 04:25:41 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 04:25:41 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 04:25:41 INFO - building 'psutil._psutil_posix' extension 04:25:41 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 04:25:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:25:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:25:41 INFO - ^ 04:25:41 INFO - 1 warning generated. 04:25:41 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 04:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:42 INFO - Successfully installed psutil 04:25:42 INFO - Cleaning up... 04:25:42 INFO - Return code: 0 04:25:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:42 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 04:25:42 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 04:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:42 INFO - 'HOME': '/Users/cltbld', 04:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PAGER': '/bin/cat', 04:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:42 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - 'XPC_FLAGS': '0x0', 04:25:42 INFO - 'XPC_SERVICE_NAME': '0', 04:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:42 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 04:25:42 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 04:25:42 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 04:25:42 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 04:25:42 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 04:25:42 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 04:25:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:45 INFO - Installing collected packages: mozsystemmonitor 04:25:45 INFO - Running setup.py install for mozsystemmonitor 04:25:45 INFO - Successfully installed mozsystemmonitor 04:25:45 INFO - Cleaning up... 04:25:45 INFO - Return code: 0 04:25:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:45 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:45 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 04:25:45 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 04:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:45 INFO - 'HOME': '/Users/cltbld', 04:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:45 INFO - 'LOGNAME': 'cltbld', 04:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:45 INFO - 'MOZ_NO_REMOTE': '1', 04:25:45 INFO - 'NO_EM_RESTART': '1', 04:25:45 INFO - 'PAGER': '/bin/cat', 04:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:45 INFO - 'PWD': '/builds/slave/test', 04:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:45 INFO - 'SHELL': '/bin/bash', 04:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:45 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:45 INFO - 'USER': 'cltbld', 04:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:45 INFO - 'XPC_FLAGS': '0x0', 04:25:45 INFO - 'XPC_SERVICE_NAME': '0', 04:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:25:45 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 04:25:45 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 04:25:45 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 04:25:45 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 04:25:45 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 04:25:45 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 04:25:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:48 INFO - warning: no files found matching '*.txt' 04:25:48 INFO - no previously-included directories found matching 'build' 04:25:48 INFO - no previously-included directories found matching 'dist' 04:25:48 INFO - no previously-included directories found matching '.git*' 04:25:48 INFO - Installing collected packages: jsonschema, functools32 04:25:48 INFO - Running setup.py install for functools32 04:25:48 INFO - warning: no files found matching '*.txt' 04:25:48 INFO - no previously-included directories found matching 'build' 04:25:48 INFO - no previously-included directories found matching 'dist' 04:25:48 INFO - no previously-included directories found matching '.git*' 04:25:48 INFO - Successfully installed jsonschema functools32 04:25:48 INFO - Cleaning up... 04:25:49 INFO - Return code: 0 04:25:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:49 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')]} 04:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:49 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')]} 04:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:49 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:49 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 04:25:49 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 04:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:49 INFO - 'HOME': '/Users/cltbld', 04:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:49 INFO - 'LOGNAME': 'cltbld', 04:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:49 INFO - 'MOZ_NO_REMOTE': '1', 04:25:49 INFO - 'NO_EM_RESTART': '1', 04:25:49 INFO - 'PAGER': '/bin/cat', 04:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:49 INFO - 'PWD': '/builds/slave/test', 04:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:49 INFO - 'SHELL': '/bin/bash', 04:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:49 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:49 INFO - 'USER': 'cltbld', 04:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:49 INFO - 'XPC_FLAGS': '0x0', 04:25:49 INFO - 'XPC_SERVICE_NAME': '0', 04:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:49 INFO - Cleaning up... 04:25:49 INFO - Return code: 0 04:25:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:49 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')]} 04:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:49 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')]} 04:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:49 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:49 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 04:25:49 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 04:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:49 INFO - 'HOME': '/Users/cltbld', 04:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:49 INFO - 'LOGNAME': 'cltbld', 04:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:49 INFO - 'MOZ_NO_REMOTE': '1', 04:25:49 INFO - 'NO_EM_RESTART': '1', 04:25:49 INFO - 'PAGER': '/bin/cat', 04:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:49 INFO - 'PWD': '/builds/slave/test', 04:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:49 INFO - 'SHELL': '/bin/bash', 04:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:49 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:49 INFO - 'USER': 'cltbld', 04:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:49 INFO - 'XPC_FLAGS': '0x0', 04:25:49 INFO - 'XPC_SERVICE_NAME': '0', 04:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:53 INFO - Downloading docopt-0.6.1.tar.gz 04:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:53 INFO - Running setup.py install for blobuploader 04:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:53 INFO - Running setup.py install for requests 04:25:54 INFO - Running setup.py install for docopt 04:25:54 INFO - Successfully installed blobuploader requests docopt 04:25:54 INFO - Cleaning up... 04:25:54 INFO - Return code: 0 04:25:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:54 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:54 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 04:25:54 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 04:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:54 INFO - 'HOME': '/Users/cltbld', 04:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:54 INFO - 'LOGNAME': 'cltbld', 04:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:54 INFO - 'MOZ_NO_REMOTE': '1', 04:25:54 INFO - 'NO_EM_RESTART': '1', 04:25:54 INFO - 'PAGER': '/bin/cat', 04:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:54 INFO - 'PWD': '/builds/slave/test', 04:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:54 INFO - 'SHELL': '/bin/bash', 04:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:54 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:54 INFO - 'USER': 'cltbld', 04:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:54 INFO - 'XPC_FLAGS': '0x0', 04:25:54 INFO - 'XPC_SERVICE_NAME': '0', 04:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:54 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-BA5dde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:54 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-JLS0bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:54 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-SgGCSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:54 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-3Qalmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-PSAG7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-JZJMxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-lSXMLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Vvaei9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-tqN1uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-8YBdsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-kEa9pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-PB4uBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-w0aRe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:55 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-NcM1X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:56 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-WIC5k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:56 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-ZNK_Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:56 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-qsH8Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:56 INFO - Running setup.py install for manifestparser 04:25:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Running setup.py install for mozcrash 04:25:56 INFO - Running setup.py install for mozdebug 04:25:56 INFO - Running setup.py install for mozdevice 04:25:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozfile 04:25:57 INFO - Running setup.py install for mozhttpd 04:25:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozinfo 04:25:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozInstall 04:25:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozleak 04:25:57 INFO - Running setup.py install for mozlog 04:25:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for moznetwork 04:25:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Running setup.py install for mozprocess 04:25:58 INFO - Running setup.py install for mozprofile 04:25:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Running setup.py install for mozrunner 04:25:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Running setup.py install for mozscreenshot 04:25:58 INFO - Running setup.py install for moztest 04:25:58 INFO - Running setup.py install for mozversion 04:25:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:58 INFO - Cleaning up... 04:25:58 INFO - Return code: 0 04:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:58 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')]} 04:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 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')]} 04:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:25:58 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 04:25:58 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 04:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:58 INFO - 'HOME': '/Users/cltbld', 04:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:58 INFO - 'LOGNAME': 'cltbld', 04:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:59 INFO - 'MOZ_NO_REMOTE': '1', 04:25:59 INFO - 'NO_EM_RESTART': '1', 04:25:59 INFO - 'PAGER': '/bin/cat', 04:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:59 INFO - 'PWD': '/builds/slave/test', 04:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:59 INFO - 'SHELL': '/bin/bash', 04:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:25:59 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:59 INFO - 'USER': 'cltbld', 04:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:59 INFO - 'XPC_FLAGS': '0x0', 04:25:59 INFO - 'XPC_SERVICE_NAME': '0', 04:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-SFbTAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-qpH3bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-5s03fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-J86rOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-4S7OAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-2RH2Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-bXdtTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:59 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-pEd6ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-xiaGjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-0ukbAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-SspPps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-VujUu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-mipC0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-e5qW5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-17Schz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-qx7Q0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-AE7EjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:01 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)) 04:26:01 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)) 04:26:01 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)) 04:26:01 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)) 04:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:26:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:03 INFO - Downloading blessings-1.6.tar.gz 04:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:03 INFO - Installing collected packages: blessings 04:26:03 INFO - Running setup.py install for blessings 04:26:03 INFO - Successfully installed blessings 04:26:03 INFO - Cleaning up... 04:26:04 INFO - Return code: 0 04:26:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:04 INFO - Reading from file tmpfile_stdout 04:26:04 INFO - Current package versions: 04:26:04 INFO - blessings == 1.6 04:26:04 INFO - blobuploader == 1.2.4 04:26:04 INFO - docopt == 0.6.1 04:26:04 INFO - functools32 == 3.2.3-2 04:26:04 INFO - jsonschema == 2.5.1 04:26:04 INFO - manifestparser == 1.1 04:26:04 INFO - mozInstall == 1.12 04:26:04 INFO - mozcrash == 1.0 04:26:04 INFO - mozdebug == 0.1 04:26:04 INFO - mozdevice == 0.49 04:26:04 INFO - mozfile == 1.2 04:26:04 INFO - mozhttpd == 0.7 04:26:04 INFO - mozinfo == 0.9 04:26:04 INFO - mozleak == 0.1 04:26:04 INFO - mozlog == 3.4 04:26:04 INFO - moznetwork == 0.27 04:26:04 INFO - mozprocess == 0.25 04:26:04 INFO - mozprofile == 0.28 04:26:04 INFO - mozrunner == 6.13 04:26:04 INFO - mozscreenshot == 0.1 04:26:04 INFO - mozsystemmonitor == 0.3 04:26:04 INFO - moztest == 0.8 04:26:04 INFO - mozversion == 1.4 04:26:04 INFO - psutil == 3.1.1 04:26:04 INFO - requests == 1.2.3 04:26:04 INFO - wsgiref == 0.1.2 04:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:04 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')]} 04:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 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')]} 04:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:26:04 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 04:26:04 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 04:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:04 INFO - 'HOME': '/Users/cltbld', 04:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:04 INFO - 'LOGNAME': 'cltbld', 04:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:04 INFO - 'MOZ_NO_REMOTE': '1', 04:26:04 INFO - 'NO_EM_RESTART': '1', 04:26:04 INFO - 'PAGER': '/bin/cat', 04:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:04 INFO - 'PWD': '/builds/slave/test', 04:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:04 INFO - 'SHELL': '/bin/bash', 04:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:26:04 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:04 INFO - 'USER': 'cltbld', 04:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:04 INFO - 'XPC_FLAGS': '0x0', 04:26:04 INFO - 'XPC_SERVICE_NAME': '0', 04:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 INFO - Cleaning up... 04:26:04 INFO - Return code: 0 04:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:04 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')]} 04:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 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')]} 04:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 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 0x100846b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa14daba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, '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.IEFttHDA6d/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.9bgTrhYySD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 04:26:04 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 04:26:04 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 04:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:04 INFO - 'HOME': '/Users/cltbld', 04:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:04 INFO - 'LOGNAME': 'cltbld', 04:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:04 INFO - 'MOZ_NO_REMOTE': '1', 04:26:04 INFO - 'NO_EM_RESTART': '1', 04:26:04 INFO - 'PAGER': '/bin/cat', 04:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:04 INFO - 'PWD': '/builds/slave/test', 04:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:04 INFO - 'SHELL': '/bin/bash', 04:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:26:04 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:04 INFO - 'USER': 'cltbld', 04:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:04 INFO - 'XPC_FLAGS': '0x0', 04:26:04 INFO - 'XPC_SERVICE_NAME': '0', 04:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:04 INFO - Cleaning up... 04:26:04 INFO - Return code: 0 04:26:04 INFO - Running post-action listener: _resource_record_post_action 04:26:04 INFO - Running post-action listener: _start_resource_monitoring 04:26:04 INFO - Starting resource monitoring. 04:26:04 INFO - [mozharness: 2017-02-27 12:26:04.944584Z] Finished create-virtualenv step (success) 04:26:04 INFO - [mozharness: 2017-02-27 12:26:04.945543Z] Running install step. 04:26:04 INFO - Running pre-action listener: _resource_record_pre_action 04:26:04 INFO - Running main action method: install 04:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:05 INFO - Reading from file tmpfile_stdout 04:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:05 INFO - Reading from file tmpfile_stdout 04:26:05 INFO - Output received: 04:26:05 INFO - Usage: mozinstall [options] installer 04:26:05 INFO - Options: 04:26:05 INFO - -h, --help show this help message and exit 04:26:05 INFO - -d DEST, --destination=DEST 04:26:05 INFO - Directory to install application into. [default: 04:26:05 INFO - "/builds/slave/test"] 04:26:05 INFO - --app=APP Application being installed. [default: firefox] 04:26:05 INFO - mkdir: /builds/slave/test/build/application 04:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:26:25 INFO - Reading from file tmpfile_stdout 04:26:25 INFO - Output received: 04:26:25 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:26:25 INFO - Running post-action listener: _resource_record_post_action 04:26:25 INFO - [mozharness: 2017-02-27 12:26:25.885942Z] Finished install step (success) 04:26:25 INFO - [mozharness: 2017-02-27 12:26:25.886071Z] Running run-tests step. 04:26:25 INFO - Running pre-action listener: _resource_record_pre_action 04:26:25 INFO - Running main action method: run_tests 04:26:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:25 INFO - 2017-02-27 04:26:25.898 screenresolution[1661:10107] starting screenresolution argv=screenresolution get 04:26:25 INFO - 2017-02-27 04:26:25.901 screenresolution[1661:10107] Display 0: 1600x1200x32@60 04:26:25 INFO - 2017-02-27 04:26:25.906 screenresolution[1662:10110] starting screenresolution argv=screenresolution list 04:26:25 INFO - Available Modes on Display 0 04:26:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:26 INFO - Intel Iris: 04:26:26 INFO - Chipset Model: Intel Iris 04:26:26 INFO - Type: GPU 04:26:26 INFO - Bus: Built-In 04:26:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:26 INFO - Vendor: Intel (0x8086) 04:26:26 INFO - Device ID: 0x0a2e 04:26:26 INFO - Revision ID: 0x0009 04:26:26 INFO - Displays: 04:26:26 INFO - Display: 04:26:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:26 INFO - Display Serial Number: 1600x1200 60 04:26:26 INFO - Main Display: Yes 04:26:26 INFO - Mirror: Off 04:26:26 INFO - Online: Yes 04:26:26 INFO - Rotation: Supported 04:26:26 INFO - Return code: 0 04:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:26 INFO - Python 2.7.3 04:26:26 INFO - Return code: 0 04:26:26 INFO - grabbing minidump binary from tooltool 04:26:26 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')]} 04:26:26 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 0x100624d30>, '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 0x10054bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:26 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 04:26:26 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 04:26:26 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 04:26:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:26 INFO - Return code: 0 04:26:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:26:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:26 INFO - ENV: RUST_BACKTRACE is now 1 04:26:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:26:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:26 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--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 04:26:26 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --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 04:26:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IEFttHDA6d/Render', 04:26:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:26 INFO - 'HOME': '/Users/cltbld', 04:26:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:26 INFO - 'LOGNAME': 'cltbld', 04:26:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:26 INFO - 'MOZ_NO_REMOTE': '1', 04:26:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:26 INFO - 'NO_EM_RESTART': '1', 04:26:26 INFO - 'PAGER': '/bin/cat', 04:26:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:26 INFO - 'PWD': '/builds/slave/test', 04:26:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:26 INFO - 'RUST_BACKTRACE': '1', 04:26:26 INFO - 'SHELL': '/bin/bash', 04:26:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bgTrhYySD/Listeners', 04:26:26 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:26:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:26 INFO - 'USER': 'cltbld', 04:26:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:26 INFO - 'XPC_FLAGS': '0x0', 04:26:26 INFO - 'XPC_SERVICE_NAME': '0', 04:26:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:26 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--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 04:26:26 INFO - mozversion application_buildid: 20170227030203 04:26:26 INFO - mozversion application_changeset: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed 04:26:26 INFO - mozversion application_display_name: Nightly 04:26:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:26 INFO - mozversion application_name: Firefox 04:26:26 INFO - mozversion application_remotingname: firefox 04:26:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:26:26 INFO - mozversion application_vendor: Mozilla 04:26:26 INFO - mozversion application_version: 54.0a1 04:26:26 INFO - mozversion platform_buildid: 20170227030203 04:26:26 INFO - mozversion platform_changeset: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed 04:26:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:26:26 INFO - mozversion platform_version: 54.0a1 04:26:26 INFO - using testdate: 1488198386 04:26:26 INFO - actual date: 1488198386 04:26:26 INFO - starting webserver on 'localhost:49245' 04:26:26 INFO - SUITE-START | Running 2 tests 04:26:26 INFO - TEST-START | dromaeo_css 04:26:26 INFO - operating with platform_type : mac_ 04:26:26 INFO - Initialising browser for dromaeo_css test... 04:26:26 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpizprPL/profile http://localhost:49245/getInfo.html) 04:26:29 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 04:26:29 INFO - PROCESS | 1672 | colorDepth:24 04:26:29 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 04:26:29 INFO - PROCESS | 1672 | __metrics 04:26:29 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:26:29 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:30 INFO - TEST-INFO | 1672: exit 0 04:26:30 INFO - Browser initialized. 04:26:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:30 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpizprPL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:42 INFO - PROCESS | 1676 | RSS: Main: 231092224 04:26:42 INFO - PROCESS | 1676 | 04:29:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 04:29:48 INFO - PROCESS | 1676 | RSS: Main: 484331520 04:29:48 INFO - PROCESS | 1676 | 04:31:31 INFO - PROCESS | 1676 | ************************* 04:31:31 INFO - PROCESS | 1676 | A coding exception was thrown and uncaught in a Task. 04:31:31 INFO - PROCESS | 1676 | 04:31:31 ERROR - PROCESS | 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:31:31 INFO - PROCESS | 1676 | Full stack: 04:31:31 INFO - PROCESS | 1676 | ************************* 04:32:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 04:32:52 INFO - PROCESS | 1676 | RSS: Main: 387305472 04:32:52 INFO - PROCESS | 1676 | 04:35:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 04:35:55 INFO - PROCESS | 1676 | RSS: Main: 339931136 04:35:55 INFO - PROCESS | 1676 | 04:38:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 04:38:58 INFO - PROCESS | 1676 | RSS: Main: 356945920 04:38:58 INFO - PROCESS | 1676 | 04:42:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 04:42:02 INFO - PROCESS | 1676 | RSS: Main: 338878464 04:42:02 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 04:45:06 INFO - PROCESS | 1676 | RSS: Main: 567455744 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | __start_tp_report 04:45:06 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 04:45:06 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 04:45:06 INFO - PROCESS | 1676 | |i|pagename|runs| 04:45:06 INFO - PROCESS | 1676 | |0;dojo.html;3233.224026233704;3237.1745204972726;3245.140037889959;3249.9350012999726;3274.1650879025847;5436.809711660093;5521.089020311644;5602.663840169587;5664.660120392774;5689.943100568993;5501.752421141048;5560.916586251209;5580.665160090387;5625.071863142576;5626.240457538231;4117.300058989979;5022.2968784370305;5076.289319495274;5089.185730283156;5102.31118798963;4683.437987441512;5179.482051794809;5204.661696989683;5207.6354655174155;5230.293910322096;4981.078500477423;5011.072951503984;5042.722650254234;5152.381714194321;5158.742062896859;3867.3812190049457;5059.848204553869;5065.062963351755;5066.240063990394;5143.996920600484;5006.399232092136;5013.774380152902;5038.067957427851;5046.545810877002;5062.569681577033;5480.205370221295;5489.011977843987;5498.395176530578;5507.201455788888;5523.447655234444;6006.699665016776;6010.158577799111;6011.849703757397;6013.9699301503215;6016.217891674054;6066.605670631395;6100.115483254903;6124.319907527348;6139.26328840542;6142.96928515359;5568.248286481314;5606.859828504279;5639.520640745542;5673.177389278531;5683.9715801420725;6286.308506064329;6303.086052522451;6303.527235457359;6307.842303942438;6313.273973493016;5799.536037117021;5830.7959221427045;6033.969830150909;6077.817665470043;6099.725512351954;6053.818385448443;6080.908786368208;6083.908741368883;6087.512998960073;6093.512518998469;5942.168096466498;5951.137085122719;5976.491998180203;5978.043513037893;5979.312379076462;5805.767769289266;6009.699515024231;6012.218411606463;6028.2766068072115;6050.848728781815;4906.239532872411;4913.21388577833;4923.335349727741;4962.255661650781;4977.776000080005;4296.570342965741;4307.978460107679;4338.089001309697;4369.038811461473;4506.616937560344;5540.473655002768;5626.718664066862;5630.746616402272;5644.491995720323;5671.035923892948;5042.294078828967;5933.821985340447;6004.489618382399;6017.638941663514;6202;5497.285352904097;5531.308586426697;5554.694491802989;5561.304836895388;5564.749586268546;3872.9031774205305;4543.363929049936;5319.148936170272;5376.46235376467;5435.755391007414;6275.780347687809;6300.716467758962;6314.463270621956;6327.303996560375;6341.556091073673;6213.2233470816145;6241.157443745036;6248.4688801452385;6251.218597675291;6260.561760676709;6156.891759483336;6216.564840461125;6228.626282423069;6265.467435267871;6281;5950.880982380415;5997.850053748517;6002.969985150046;6017.518598512196;6018.247719035121;6020.367861374668;6073.119397687399;6080.8783824324155;6084.087386892002;6106.236720409949;4526.932096018628;5845.006348920779;5853.912191317048;5857.824265272048;5859.531237501075;4790.616750660009;5743.994800909741;5772.624779389326;5776.480116789509;5789.2763404574425;5752.33848107473;5772.711364431678;5783.624064435799;5787.36339002701;5812.3025236971835;5866.120081987736;5870.031444811559;5872.442117998783;5873.442023007808;5881.5588830837005;5542.63972841764;5710.771569137188;5718.1708652246025;5732.742026608896;5735.598508104393 04:45:06 INFO - PROCESS | 1676 | |1;ext.html;756.795665170404;778.3073064972176;843.472829481574;859.9097094805041;860.0238729042538;26206.47587048258;27268.31829204271;27301.59047614285;36397.63602363975;37154.814225928836;37634.623653763454;38024.42963355552;38066.09975453802;38101;38136.42795358072;8836.734897953056;9001.414908030989;9001.999999999967;9007.1443212895;9020.639174433014;7177.85644287114;7407.925920740804;7409.70361185552;8824.514651694186;8959.955200224022;7336.413086953057;7373.078365204349;10540.314879532843;10750.731231719192;10772.838407423895;10655.307405018688;10717.678469645924;10735.892641073568;10743.785124297548;10748.570057197741;10490.737731556696;10544.367337959748;10547.472626368652;10549.41978191199;10569.10162636177;25349;26061.478770424674;35256.766013189415;35817.64182358195;35932;3679.1168535432503;3714.387126124186;3754.662080412776;3776.2825063237897;3844.375388440025;26074.087406940667;26676.998450232426;26741.180998845364;26828.92684292626;26923;2934.7072524775913;3004.263955330936;3020.501617233154;3080.337727388622;3097.41149181657;304191;304270.47864760534;304445;305139;305488.9999999978;36958;45580.77209613997;45855.85360366017;45874.85312867205;45889.31166032512;39965.80017099896;40718.38922416166;40722.77831665055;42879.35680964788;47545.81135471572;10920.781584368267;12084;12168.939155304166;12179.269243845398;13368.598942031755;11638.76722465546;11696.532138714527;11701.005414539859;11701.531938722355;11714.70713232159;11143.33140011602;11176.217664763552;11192.160587955936;11207.327560346243;11222.607208747655;4360.055010869071;5104.243708397424;5104.2993829473335;5105.595961110725;5116.718580478109;1008.8537162111453;1027.671145233518;1091.956321747137;1123.730304726876;1157.0685598093448;22155;24285.7571424287;25257.24228273118;25433.745662543508;25512.872435637702;1186.1993154620598;1199.1186477938709;1221.4137214137263;1227.7851376009341;1251.9436625351882;13015.804762928563;13241.668958276121;13271.938244940382;13289.734205315839;13300.268485233211;394705;394721;394978;396385;397481;50498;50505.494945050814;50599.24101138486;50715.23927141096;50720.23919641208;1380.9723805523834;1408.3028900694017;1411.1533080152033;1415.2287003582867;1419.7302512522588;23121.047066100415;23987.225327176842;24610.261692149263;24777.88499517562;24839.751602483742;41125.79437102795;41379.7931010343;41383.37924931068;41409;41409.1718165641;282304;283234;283541;283869;284264;30358.392832143676;31018.53472197964;31049;31073;31077.844610776803;28230.43539129247;37501.6249837509;37986.62013379941;38134.618653814214;38268.61731382651;32244.032679019667;32399.51400728944;32751;33828.66171338255;34070.82964585161;32401;32545.511817323233;32653.346933061683;33689.494657579664;33729;26744.866275668497;33143.00570982874;33175.17062073467;33197.33605327832;33271.50092748562;26713.866430667724;26941.461170776867;28463;29180.416391672472;29513.85243073771;21397.823119728564;21654.133834646436;22466.213682521033;22626.98178581935;22664.433389164744 04:45:06 INFO - PROCESS | 1676 | |2;jquery.html;337.49881426082277;362.7214070401833;390.8202226975591;401.3097472347563;418.88480667816344;13521.25633090181;13759.31203439829;14850.628734281649;20404.693929591067;21267.255646052392;17748.46754597361;21461.248856290033;21814.563708725815;22410.88794556029;22677.773222267773;5881.617694849831;5982.102684597302;6007.429294217042;6141.846453838645;6150.938490615104;5983.611065280765;6066.545009124311;6102.633841969496;6128.662923539204;6136.570440069197;3856.9807150964207;4008.4588580541545;4041.1715598302276;4046.7571945683208;6354.9364506354805;6523.836904077389;6615;6627.204735431755;6756.662166891685;6766.221884483273;5869.882602347971;5874.823755287348;5878.647281163101;5880.117982302646;5883.646981181143;25489;26105.869470652717;26169.214923552325;26210.73789262121;26572.601410978852;2675.7859371250447;2734;2753.559430491132;2758.4207316463567;2772.002079251468;10070.446125463097;10325.225608079425;10422.739431514197;12408.503659853684;14111;1419.304540775023;1776.4936992957075;1795.7396177554313;1822.307523141211;1943.1741509858396;120103.3994830029;125872;125892;126870;126896.99999999908;11307.208495405243;11766.705832354259;11813.468393922294;11840.072425974871;11864.940675296568;15929.362825487082;15941.282642281125;15951.680966380607;15957.361705531881;15990.840091599168;8403.537805420638;8596.484210947363;8650.783730406665;8724.258438032712;8728.301735861116;6923.2038315593345;8123.675052997932;8150.796230094295;8185.503421456394;8336.124706905808;4694.155052090657;4784.545468180518;4809.495003024702;4843.1524483216;4897.730624815598;1685.578605348663;1804.9909750451427;1825.7352683860765;1910.6274276516224;2051.8050785175383;1007.8337074382645;1022.8312328465869;1037.3620223562455;1079.3092420850662;1092.9617463388743;20366.89816550908;21815.127394904026;21857.3606979474;22032.559348813254;22099.889500552395;963.5182408795603;966.8694726212012;982;1080.8811030786608;1097.6048622495896;10751.946240268748;11027.897210278908;11265.54937802495;11537.48081336342;11600.88399116015;385113;493332;581730;595676;596132;131684.3415782915;131911.3404432991;134680.32659836835;134731;135369.3231533836;984.8276551603441;997.2321312589411;1025.2566889005411;1029.7477118105962;1030.062642994871;19014.524636884187;19183.904080479508;19369.934653594188;19414;19438.8056119437;54809.72595136999;55458.44541554533;56023.719881400335;56798.86402271849;56993.43006570047;58712;77878.6106069466;79808.60095699716;79814.80277795954;79913;8229.341652667892;8286.958565207135;8431.704890329054;8502.489850608983;8504.574771261536;12846.229226246454;12914.741705166032;13332.066755327034;13338.26639534796;13437.596872093853;10829.945850271013;11222.943885280521;11401.429928503376;11404.82892756626;11423.657290281304;10496.422696751752;10910.072643825364;11024.669259922215;11228.4385780709;11270.380129092979;10999.395033273247;11188.66434006981;11488.080953523866;12033.097517686383;12109.212901161749;8244.917550824415;8541.743747687578;8542.78643033929;8588.699395521127;8684.088170741981;11331.263467874562;11446.713832154262;11719.06247500215;11808.70478238051;11876.287422754662 04:45:06 INFO - PROCESS | 1676 | |3;mootools.html;1442.5455981365862;1444.1335198880672;1458.67179884526;1466.428093043713;1472.168224952902;8327.292180164686;8723.738287851358;8730.388872778907;8730.825383492327;8737.038925718165;8319.708810191645;8567.228949394568;8614.827703445928;8623.784405389853;8630.223279904807;2266.252136794854;2308.480591866825;2310.792028717415;2311.7919387255142;2314.7569505201964;2267.047839907243;2304.193532263711;2306.8039216666602;2308;2311.3181611424584;2259.062489067035;2260.9321720348416;2280.6579013147993;2281.4182383492184;2284.6116160252714;2242.6411774116227;2244.450109723112;2261.920832770845;2266.9206577769864;2268.3648578398074;1857.349927525369;2260.6156953317977;2262.725960409794;2262.8615957919774;2264.105678257079;8641.783955401103;8705.260052895512;8714.477131372138;8716.694915677921;8732.12678732128;5113.386393632788;5276.868078298074;5279.41926388097;5282.498162674539;5289.418164001957;3276.737860971117;3356.664333566648;3507.14075051614;3572.2855428914063;3572.91067723309;998.5356809083811;1208.112037652325;1218.3299185448057;1224.7489264700714;1239.8884100431005;10152.289339746221;10467.685969420929;10491.895081049244;10955.233133680646;10974.341539507655;4333.836299501381;4482.7758612069265;4487.775611219426;4507.346434766941;4518.683692141584;8887.644494220289;8901.421407608485;8904.421212621159;8911.37620366581;8918.821623567492;4465.196264672325;4627.8611641650805;4635.6986795858165;5171.146760784503;5171.172612382001;4651.209294419957;4815.22956326986;4856.1016212000895;4871.610271178297;4877.902441951142;3474.530938323294;3511.736619753529;3549.290141971616;3606.2607165531003;3622;1081.6917178604217;1091.2743025887696;1106.1482658353184;1107.7064577886867;1114.7268919114706;762.4281788658507;843.6920524008815;891.7547674389594;893.2005854759954;938.957746901391;5347.144456886879;5406.432324605938;5662.405447428043;5771.451712087345;5809.680467574324;881.6605606841413;955.7610597350663;993.6621548673486;998.1964518562627;1027.6916924922493;3700.3709369407266;3715.3126671565306;3814.732968692165;3860.1314704191896;3889.824957876846;9672.516374181403;9685.128338449573;9852.014798520235;9861.309708320348;9866.358686685342;9785.559649815776;9813.11681948628;9816.165625921734;9818.41089534616;9821.312508124505;7396.741114061089;7780.416468764865;8016.398770092266;8024.358051355877;8044.316233120133;4816.638752093677;5502.422245664307;5789.8552536186935;5830.212921255746;5833.125031245348;8985.371024028254;9084;9295.535223238676;9416.199623032118;9522.904770952202;9109.089091090838;9400.76498087526;9498.14516693501;9534.951155372764;9541.141297283279;7183.712651493882;7322.1579518356075;7433.516821406592;7435.182129965808;7439.442041846775;7885.921140788748;7964.831651513684;7974.003249593801;8041.67833286662;8048.798780030312;7171.892421613576;7244.637768111679;7305.1233851938105;7312.890306645511;7315.195328513752;6997.230304666381;7104.609246491493;7117.537360071578;7146.392556632744;7190.245024272376;6388.680565971776;6505.121808555974;6513.478921686159;6515.934840651533;6521.054447105238;3899.3886045447166;4622.86131416058;4848;5077.111505486451;5087.364079490064;4861.4895435980125;4925.48282430354;5000.64995450315;5022.397312322545;5216.921746173886 04:45:06 INFO - PROCESS | 1676 | |4;prototype.html;295.7707776473233;338.85937336005543;340.2446568617669;346.2617659350061;367.97792132472034;4421.734695918243;4618.861434156972;5118.539331460172;5270.183121616146;5358.651687640306;4832.903341933168;5320.680759154454;5347.0909945309295;5351.25082488452;5352.2239275305055;3526;4191.643710284629;4219;4224.260754367989;4259.275923093066;3801.4414090223013;3923.941140882889;3999.6600288975474;4081.4082507821972;4235.1529694061155;3945.2504024235304;3993.3011722948513;4009.4363198352667;4018.2967980603426;4031.3549832026733;3982.303096958021;3993.900152496182;4007.338789099795;4027.5230733099224;4033.878983630496;3472.4791281307753;3495.846370697689;3503.6146023937345;3507.4563442666426;3517.718582513393;4449.822007119711;4667.766611669403;5158.587313014949;5225.529702326771;5268.288781014552;3710.7959062251566;3717.739758216926;4407.427034485529;4471.904383426049;4611.400517932647;5330.706811125387;5643.871225754865;5644.915326270109;5645.294338207724;5685.862827434488;3229.9677003229904;3769.359208934488;3798.2783271178387;3802.790846503441;3824.8661296854757;5420.024395608789;5532.446755324516;5751.683657398799;5829.533637309005;5932.406759324076;3722.571904231048;4102.933237358248;4126.442930204384;4153.7507749535125;4224.366345048267;3639.5632524097277;4274.0339443855555;4289.134226611434;4298.6131248187185;4325.221460137205;4553;4615.561521655437;4664.486906440289;4719.551642593948;4887.926681099786;5245.475452454724;5456.945430545723;5682;5693.363570065605;5812.912806307909;1228.2753175626424;1272.9299888506036;1358.7622166120889;1376.0917794255743;1400.8233084209312;786.7049856303886;871.5947084605561;878.9912100879037;931.3154831199063;980.3333733061444;4381.816909434435;5042.663694121061;5073.528676683721;5083.593312534988;5103.478599766149;5159.484051594885;5479.150731636602;5563.888722225533;5576.9163462548095;5624.959382514248;4033.38659573836;4698.003348576841;4778.95221047792;4971.254311853251;5083.974580127149;2604.9088281910044;2703.337682267818;2719.6600424946882;2907.941841163165;2919.5182794838615;5402.810901618424;5450.29146210998;5635.69003704792;5706.28671416073;5735.283089613798;5025.170846810235;5284.524392804589;5626.521745651666;5678.5741069419955;5748.7125643717645;4824.252240902595;5230.555402790729;5361.12360673761;5442.2108794225405;5755.597108202385;5000.599952003904;5339.985402773461;5530.28561146046;5544.584156188222;5550.916736249041;4818.759062046954;4921.163402221559;5010.599152067899;5474.698891561003;5495.560355171497;5613.354464236665;5661.122526008476;5689;5712.714364281686;5820.679862607597;3549.6095429502216;3999.3401088821183;4056.634902858757;4165.14614504032;4176.373543968429;5795.304563452412;5795.623284486495;5820.650760954356;5826.563007774519;5857.912131318119;3968.861089861841;5442.42169770762;5611.747471363717;5649.350324712711;5691.430856914276;5288.836455979678;5364.490373414519;5650.23721797552;5663.375439718666;5668.773249069991;5205.735505055313;5263.894582137794;5323.547498462674;5548.334199896039;5568.470995255444;5404.567634589145;5568.77724891016;5642.956053130184;5657.490825825531;5659.943400565941;5507.366652834815;5522.134505846004;5529.921665275233;5532.834014979557;5534.723263836872 04:45:06 INFO - PROCESS | 1676 | |5;yui.html;617.8331850400389;754.8037510247337;766.2337662337659;826.3182874128844;828.5732847583494;14304.856951430482;15051.849481505182;15052.849471505282;15054.623634409145;15062.020968637045;13822.101563398372;13914.165150091001;13930.721385572282;13931.791023134636;13936;823.7034667519688;922.9261659067292;925.6436272035264;938.451006161393;942.3026960049583;939.5865819039601;954.1031430455384;954.5322791831987;956.8421210500259;957.2533423929347;988.9505524723735;990.5443495991852;990.9256805739562;992.8113658404916;993.2897977945768;852.1521086518953;984.4044353166303;988.6440881282732;989.1888651305932;989.6931951095183;732.3445516262915;732.5128789355126;733.0763238319755;733.2154594583798;733.7248531800575;15117.244137793066;15357.308921098578;15450.381984720598;15476.922615386851;15666.608334791608;13836.930815345959;14024.579262622137;14062.789058164135;14135.575932722035;14208.92895535526;9835.360701554448;11681.299122052704;11699.649010529698;12011.339376334297;12176.26942383451;3566.554180727409;3628.2562074774874;3632.673059424638;3639.672429481333;3664.3404187246283;96136.51931740367;97421;98369;99100;100797.48803767949;10614.416207108683;10616.469176541143;10683;10695.94652026735;11053.944730276296;22553;23019.654705179437;23020.539589208456;23032.539349212922;23156;7345.853082938418;7397.334239918433;7451.701931922662;7470.402367810562;7537.2462753725285;3947.190825880745;4027.4160246764054;4120.896977575585;4172.144710334374;4249.128928569636;3454.9818145829627;3585.372559802024;3590.7127429805555;3591.2996965591983;3591.353556359828;680.7753441364338;686.4508393285452;695.4818660098158;730.837789661317;740.2301606329464;645.8320836582428;668.5086461450829;670.7969445895886;699.7166147710185;700.3136925812732;9601.951990240004;9722.562484688206;9887.901120988698;10035.548400322003;10122.443265620313;650.5992886249724;674.7264488810629;681.32208452589;713.8286811165386;728.4099879097947;4101.835926562904;4565.680402371869;4568.132054909556;4839.564439200419;4849.515048495122;81896;84303;96027.55958660625;97436;98068;54644.72677636586;68968.27579310557;70812.22969425806;79047;84290.15709842945;70795.64602176956;71751.64124179346;72905;73406.63296683696;74508.25491745121;9114.635414583343;9240.168384845396;9306.115918987685;9420;9452.480113593818;36475.817620912785;47783.761081194374;49356;49529;49765;46028.794241151234;50040.748981275756;61497.38502614917;62643.74712505633;64808.67595661992;11248.831267531157;11377.658670239905;11859.05127589808;11985.940070299594;11992.220505667452;11809.23239989398;11958.342291174069;11971.319748997998;12024.75950480968;12182.512699492276;11248.212625116163;11450.146248283994;11905.404729763304;11907.761844762883;12041.397930103285;11433.314001159957;11609.5356185755;11934.403279836148;12034.939825300817;12043.578474753342;8325.666973321;11110.722231944266;11742.706432338919;12114.273143611412;12360.814587781011;9469.402404737517;9491.335606507479;9507.239420846177;9562.617495300388;9834.311598188058;6704.698288577123;8399.496030238206;8687.782805429662;9719.56261968199;10600.259878623714 04:45:06 INFO - PROCESS | 1676 | __end_tp_report 04:45:06 INFO - PROCESS | 1676 | __start_cc_report 04:45:06 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,3102 04:45:06 INFO - PROCESS | 1676 | __end_cc_report 04:45:06 INFO - PROCESS | 1676 | __startTimestamp1488199506416__endTimestamp 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | ------- Summary: start ------- 04:45:06 INFO - PROCESS | 1676 | Number of tests: 6 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5559.67 Median:5735.60 stddev:671.69 (11.7%) stddev-sans-first:648.49 04:45:06 INFO - PROCESS | 1676 | Values: 3233.2 3237.2 3245.1 3249.9 3274.2 5436.8 5521.1 5602.7 5664.7 5689.9 5501.8 5560.9 5580.7 5625.1 5626.2 4117.3 5022.3 5076.3 5089.2 5102.3 4683.4 5179.5 5204.7 5207.6 5230.3 4981.1 5011.1 5042.7 5152.4 5158.7 3867.4 5059.8 5065.1 5066.2 5144.0 5006.4 5013.8 5038.1 5046.5 5062.6 5480.2 5489.0 5498.4 5507.2 5523.4 6006.7 6010.2 6011.8 6014.0 6016.2 6066.6 6100.1 6124.3 6139.3 6143.0 5568.2 5606.9 5639.5 5673.2 5684.0 6286.3 6303.1 6303.5 6307.8 6313.3 5799.5 5830.8 6034.0 6077.8 6099.7 6053.8 6080.9 6083.9 6087.5 6093.5 5942.2 5951.1 5976.5 5978.0 5979.3 5805.8 6009.7 6012.2 6028.3 6050.8 4906.2 4913.2 4923.3 4962.3 4977.8 4296.6 4308.0 4338.1 4369.0 4506.6 5540.5 5626.7 5630.7 5644.5 5671.0 5042.3 5933.8 6004.5 6017.6 6202.0 5497.3 5531.3 5554.7 5561.3 5564.7 3872.9 4543.4 5319.1 5376.5 5435.8 6275.8 6300.7 6314.5 6327.3 6341.6 6213.2 6241.2 6248.5 6251.2 6260.6 6156.9 6216.6 6228.6 6265.5 6281.0 5950.9 5997.9 6003.0 6017.5 6018.2 6020.4 6073.1 6080.9 6084.1 6106.2 4526.9 5845.0 5853.9 5857.8 5859.5 4790.6 5744.0 5772.6 5776.5 5789.3 5752.3 5772.7 5783.6 5787.4 5812.3 5866.1 5870.0 5872.4 5873.4 5881.6 5542.6 5710.8 5718.2 5732.7 5735.6 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:46261.87 Median:304357.74 stddev:87472.21 (28.7%) stddev-sans-first:87650.86 04:45:06 INFO - PROCESS | 1676 | Values: 756.8 778.3 843.5 859.9 860.0 26206.5 27268.3 27301.6 36397.6 37154.8 37634.6 38024.4 38066.1 38101.0 38136.4 8836.7 9001.4 9002.0 9007.1 9020.6 7177.9 7407.9 7409.7 8824.5 8960.0 7336.4 7373.1 10540.3 10750.7 10772.8 10655.3 10717.7 10735.9 10743.8 10748.6 10490.7 10544.4 10547.5 10549.4 10569.1 25349.0 26061.5 35256.8 35817.6 35932.0 3679.1 3714.4 3754.7 3776.3 3844.4 26074.1 26677.0 26741.2 26828.9 26923.0 2934.7 3004.3 3020.5 3080.3 3097.4 304191.0 304270.5 304445.0 305139.0 305489.0 36958.0 45580.8 45855.9 45874.9 45889.3 39965.8 40718.4 40722.8 42879.4 47545.8 10920.8 12084.0 12168.9 12179.3 13368.6 11638.8 11696.5 11701.0 11701.5 11714.7 11143.3 11176.2 11192.2 11207.3 11222.6 4360.1 5104.2 5104.3 5105.6 5116.7 1008.9 1027.7 1092.0 1123.7 1157.1 22155.0 24285.8 25257.2 25433.7 25512.9 1186.2 1199.1 1221.4 1227.8 1251.9 13015.8 13241.7 13271.9 13289.7 13300.3 394705.0 394721.0 394978.0 396385.0 397481.0 50498.0 50505.5 50599.2 50715.2 50720.2 1381.0 1408.3 1411.2 1415.2 1419.7 23121.0 23987.2 24610.3 24777.9 24839.8 41125.8 41379.8 41383.4 41409.0 41409.2 282304.0 283234.0 283541.0 283869.0 284264.0 30358.4 31018.5 31049.0 31073.0 31077.8 28230.4 37501.6 37986.6 38134.6 38268.6 32244.0 32399.5 32751.0 33828.7 34070.8 32401.0 32545.5 32653.3 33689.5 33729.0 26744.9 33143.0 33175.2 33197.3 33271.5 26713.9 26941.5 28463.0 29180.4 29513.9 21397.8 21654.1 22466.2 22627.0 22664.4 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:33656.90 Median:21944.96 stddev:90588.70 (412.8%) stddev-sans-first:90808.28 04:45:06 INFO - PROCESS | 1676 | Values: 337.5 362.7 390.8 401.3 418.9 13521.3 13759.3 14850.6 20404.7 21267.3 17748.5 21461.2 21814.6 22410.9 22677.8 5881.6 5982.1 6007.4 6141.8 6150.9 5983.6 6066.5 6102.6 6128.7 6136.6 3857.0 4008.5 4041.2 4046.8 6354.9 6523.8 6615.0 6627.2 6756.7 6766.2 5869.9 5874.8 5878.6 5880.1 5883.6 25489.0 26105.9 26169.2 26210.7 26572.6 2675.8 2734.0 2753.6 2758.4 2772.0 10070.4 10325.2 10422.7 12408.5 14111.0 1419.3 1776.5 1795.7 1822.3 1943.2 120103.4 125872.0 125892.0 126870.0 126897.0 11307.2 11766.7 11813.5 11840.1 11864.9 15929.4 15941.3 15951.7 15957.4 15990.8 8403.5 8596.5 8650.8 8724.3 8728.3 6923.2 8123.7 8150.8 8185.5 8336.1 4694.2 4784.5 4809.5 4843.2 4897.7 1685.6 1805.0 1825.7 1910.6 2051.8 1007.8 1022.8 1037.4 1079.3 1093.0 20366.9 21815.1 21857.4 22032.6 22099.9 963.5 966.9 982.0 1080.9 1097.6 10751.9 11027.9 11265.5 11537.5 11600.9 385113.0 493332.0 581730.0 595676.0 596132.0 131684.3 131911.3 134680.3 134731.0 135369.3 984.8 997.2 1025.3 1029.7 1030.1 19014.5 19183.9 19369.9 19414.0 19438.8 54809.7 55458.4 56023.7 56798.9 56993.4 58712.0 77878.6 79808.6 79814.8 79913.0 8229.3 8287.0 8431.7 8502.5 8504.6 12846.2 12914.7 13332.1 13338.3 13437.6 10829.9 11222.9 11401.4 11404.8 11423.7 10496.4 10910.1 11024.7 11228.4 11270.4 10999.4 11188.7 11488.1 12033.1 12109.2 8244.9 8541.7 8542.8 8588.7 8684.1 11331.3 11446.7 11719.1 11808.7 11876.3 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5435.05 Median:5318.28 stddev:2984.19 (56.1%) stddev-sans-first:2977.48 04:45:06 INFO - PROCESS | 1676 | Values: 1442.5 1444.1 1458.7 1466.4 1472.2 8327.3 8723.7 8730.4 8730.8 8737.0 8319.7 8567.2 8614.8 8623.8 8630.2 2266.3 2308.5 2310.8 2311.8 2314.8 2267.0 2304.2 2306.8 2308.0 2311.3 2259.1 2260.9 2280.7 2281.4 2284.6 2242.6 2244.5 2261.9 2266.9 2268.4 1857.3 2260.6 2262.7 2262.9 2264.1 8641.8 8705.3 8714.5 8716.7 8732.1 5113.4 5276.9 5279.4 5282.5 5289.4 3276.7 3356.7 3507.1 3572.3 3572.9 998.5 1208.1 1218.3 1224.7 1239.9 10152.3 10467.7 10491.9 10955.2 10974.3 4333.8 4482.8 4487.8 4507.3 4518.7 8887.6 8901.4 8904.4 8911.4 8918.8 4465.2 4627.9 4635.7 5171.1 5171.2 4651.2 4815.2 4856.1 4871.6 4877.9 3474.5 3511.7 3549.3 3606.3 3622.0 1081.7 1091.3 1106.1 1107.7 1114.7 762.4 843.7 891.8 893.2 939.0 5347.1 5406.4 5662.4 5771.5 5809.7 881.7 955.8 993.7 998.2 1027.7 3700.4 3715.3 3814.7 3860.1 3889.8 9672.5 9685.1 9852.0 9861.3 9866.4 9785.6 9813.1 9816.2 9818.4 9821.3 7396.7 7780.4 8016.4 8024.4 8044.3 4816.6 5502.4 5789.9 5830.2 5833.1 8985.4 9084.0 9295.5 9416.2 9522.9 9109.1 9400.8 9498.1 9535.0 9541.1 7183.7 7322.2 7433.5 7435.2 7439.4 7885.9 7964.8 7974.0 8041.7 8048.8 7171.9 7244.6 7305.1 7312.9 7315.2 6997.2 7104.6 7117.5 7146.4 7190.2 6388.7 6505.1 6513.5 6515.9 6521.1 3899.4 4622.9 4848.0 5077.1 5087.4 4861.5 4925.5 5000.6 5022.4 5216.9 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:4516.13 Median:5093.73 stddev:1361.80 (26.7%) stddev-sans-first:1328.27 04:45:06 INFO - PROCESS | 1676 | Values: 295.8 338.9 340.2 346.3 368.0 4421.7 4618.9 5118.5 5270.2 5358.7 4832.9 5320.7 5347.1 5351.3 5352.2 3526.0 4191.6 4219.0 4224.3 4259.3 3801.4 3923.9 3999.7 4081.4 4235.2 3945.3 3993.3 4009.4 4018.3 4031.4 3982.3 3993.9 4007.3 4027.5 4033.9 3472.5 3495.8 3503.6 3507.5 3517.7 4449.8 4667.8 5158.6 5225.5 5268.3 3710.8 3717.7 4407.4 4471.9 4611.4 5330.7 5643.9 5644.9 5645.3 5685.9 3230.0 3769.4 3798.3 3802.8 3824.9 5420.0 5532.4 5751.7 5829.5 5932.4 3722.6 4102.9 4126.4 4153.8 4224.4 3639.6 4274.0 4289.1 4298.6 4325.2 4553.0 4615.6 4664.5 4719.6 4887.9 5245.5 5456.9 5682.0 5693.4 5812.9 1228.3 1272.9 1358.8 1376.1 1400.8 786.7 871.6 879.0 931.3 980.3 4381.8 5042.7 5073.5 5083.6 5103.5 5159.5 5479.2 5563.9 5576.9 5625.0 4033.4 4698.0 4779.0 4971.3 5084.0 2604.9 2703.3 2719.7 2907.9 2919.5 5402.8 5450.3 5635.7 5706.3 5735.3 5025.2 5284.5 5626.5 5678.6 5748.7 4824.3 5230.6 5361.1 5442.2 5755.6 5000.6 5340.0 5530.3 5544.6 5550.9 4818.8 4921.2 5010.6 5474.7 5495.6 5613.4 5661.1 5689.0 5712.7 5820.7 3549.6 3999.3 4056.6 4165.1 4176.4 5795.3 5795.6 5820.7 5826.6 5857.9 3968.9 5442.4 5611.7 5649.4 5691.4 5288.8 5364.5 5650.2 5663.4 5668.8 5205.7 5263.9 5323.5 5548.3 5568.5 5404.6 5568.8 5643.0 5657.5 5659.9 5507.4 5522.1 5529.9 5532.8 5534.7 04:45:06 INFO - PROCESS | 1676 | 04:45:06 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18549.48 Median:31057.61 stddev:26169.29 (84.3%) stddev-sans-first:26208.06 04:45:06 INFO - PROCESS | 1676 | Values: 617.8 754.8 766.2 826.3 828.6 14304.9 15051.8 15052.8 15054.6 15062.0 13822.1 13914.2 13930.7 13931.8 13936.0 823.7 922.9 925.6 938.5 942.3 939.6 954.1 954.5 956.8 957.3 989.0 990.5 990.9 992.8 993.3 852.2 984.4 988.6 989.2 989.7 732.3 732.5 733.1 733.2 733.7 15117.2 15357.3 15450.4 15476.9 15666.6 13836.9 14024.6 14062.8 14135.6 14208.9 9835.4 11681.3 11699.6 12011.3 12176.3 3566.6 3628.3 3632.7 3639.7 3664.3 96136.5 97421.0 98369.0 99100.0 100797.5 10614.4 10616.5 10683.0 10695.9 11053.9 22553.0 23019.7 23020.5 23032.5 23156.0 7345.9 7397.3 7451.7 7470.4 7537.2 3947.2 4027.4 4120.9 4172.1 4249.1 3455.0 3585.4 3590.7 3591.3 3591.4 680.8 686.5 695.5 730.8 740.2 645.8 668.5 670.8 699.7 700.3 9602.0 9722.6 9887.9 10035.5 10122.4 650.6 674.7 681.3 713.8 728.4 4101.8 4565.7 4568.1 4839.6 4849.5 81896.0 84303.0 96027.6 97436.0 98068.0 54644.7 68968.3 70812.2 79047.0 84290.2 70795.6 71751.6 72905.0 73406.6 74508.3 9114.6 9240.2 9306.1 9420.0 9452.5 36475.8 47783.8 49356.0 49529.0 49765.0 46028.8 50040.7 61497.4 62643.7 64808.7 11248.8 11377.7 11859.1 11985.9 11992.2 11809.2 11958.3 11971.3 12024.8 12182.5 11248.2 11450.1 11905.4 11907.8 12041.4 11433.3 11609.5 11934.4 12034.9 12043.6 8325.7 11110.7 11742.7 12114.3 12360.8 9469.4 9491.3 9507.2 9562.6 9834.3 6704.7 8399.5 8687.8 9719.6 10600.3 04:45:06 INFO - PROCESS | 1676 | -------- Summary: end -------- 04:45:06 INFO - PROCESS | 1676 | 04:45:07 INFO - TEST-INFO | 1676: exit 0 04:45:07 INFO - TEST-OK | dromaeo_css | took 1120709ms 04:45:07 INFO - TEST-START | kraken 04:45:07 INFO - operating with platform_type : mac_ 04:45:07 INFO - Initialising browser for kraken test... 04:45:07 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmp1RUXUm/profile http://localhost:49245/getInfo.html) 04:45:09 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 04:45:09 INFO - PROCESS | 1682 | colorDepth:24 04:45:09 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 04:45:09 INFO - PROCESS | 1682 | __metrics 04:45:10 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:45:10 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:10 INFO - TEST-INFO | 1682: exit 0 04:45:10 INFO - Browser initialized. 04:45:10 INFO - Running cycle 1/1 for kraken test... 04:45:10 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmp1RUXUm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:23 INFO - PROCESS | 1684 | RSS: Main: 231223296 04:45:23 INFO - PROCESS | 1684 | 04:45:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:26 INFO - PROCESS | 1684 | RSS: Main: 284049408 04:45:26 INFO - PROCESS | 1684 | 04:45:29 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 04:45:30 INFO - PROCESS | 1684 | RSS: Main: 286810112 04:45:30 INFO - PROCESS | 1684 | 04:45:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 04:45:34 INFO - PROCESS | 1684 | RSS: Main: 376287232 04:45:34 INFO - PROCESS | 1684 | 04:45:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 04:45:36 INFO - PROCESS | 1684 | RSS: Main: 280887296 04:45:36 INFO - PROCESS | 1684 | 04:45:38 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:39 INFO - PROCESS | 1684 | RSS: Main: 282898432 04:45:39 INFO - PROCESS | 1684 | 04:45:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:43 INFO - PROCESS | 1684 | RSS: Main: 325541888 04:45:43 INFO - PROCESS | 1684 | 04:45:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:47 INFO - PROCESS | 1684 | RSS: Main: 326733824 04:45:47 INFO - PROCESS | 1684 | 04:45:50 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 04:45:50 INFO - PROCESS | 1684 | RSS: Main: 324722688 04:45:50 INFO - PROCESS | 1684 | 04:45:52 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:53 INFO - PROCESS | 1684 | RSS: Main: 299962368 04:45:53 INFO - PROCESS | 1684 | 04:45:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:55 INFO - PROCESS | 1684 | RSS: Main: 304922624 04:45:55 INFO - PROCESS | 1684 | 04:45:57 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:58 INFO - PROCESS | 1684 | RSS: Main: 311439360 04:45:58 INFO - PROCESS | 1684 | 04:46:01 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:02 INFO - PROCESS | 1684 | RSS: Main: 324210688 04:46:02 INFO - PROCESS | 1684 | 04:46:05 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:05 INFO - PROCESS | 1684 | RSS: Main: 318414848 04:46:05 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 04:46:07 INFO - PROCESS | 1684 | RSS: Main: 363134976 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | __start_tp_report 04:46:07 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 04:46:07 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 04:46:07 INFO - PROCESS | 1684 | |i|pagename|runs| 04:46:07 INFO - PROCESS | 1684 | |0;ai-astar;114;115;115;114;114;114;114;114;115;114 04:46:07 INFO - PROCESS | 1684 | |1;audio-beat-detection;151;127;138;185;114;113;114;124;165;112 04:46:07 INFO - PROCESS | 1684 | |2;audio-dft;185;186;182;188;185;184;181;184;185;185 04:46:07 INFO - PROCESS | 1684 | |3;audio-fft;78;61;62;90;63;62;61;59;77;59 04:46:07 INFO - PROCESS | 1684 | |4;audio-oscillator;87;71;88;69;71;93;108;84;68;85 04:46:07 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;88;101;134;87;87;87;87;92;134 04:46:07 INFO - PROCESS | 1684 | |6;imaging-darkroom;95;95;128;133;95;94;94;94;94;95 04:46:07 INFO - PROCESS | 1684 | |7;imaging-desaturate;88;88;86;87;88;86;85;88;82;87 04:46:07 INFO - PROCESS | 1684 | |8;json-parse-financial;64;62;63;61;64;63;64;62;63;63 04:46:07 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;56;57;68;70;67;61;60;60;61;61 04:46:07 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;91;86;90;87;86;89;88;90;89;90 04:46:07 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;139;142;142;141;139;140;139;142;182;157 04:46:07 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;183;174;195;170;168;177;227;233;171;173 04:46:07 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;67;67;66;67;66;66;65;67;66;66 04:46:07 INFO - PROCESS | 1684 | __end_tp_report 04:46:07 INFO - PROCESS | 1684 | __start_cc_report 04:46:07 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,2117 04:46:07 INFO - PROCESS | 1684 | __end_cc_report 04:46:07 INFO - PROCESS | 1684 | __startTimestamp1488199567828__endTimestamp 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | ------- Summary: start ------- 04:46:07 INFO - PROCESS | 1684 | Number of tests: 14 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:46:07 INFO - PROCESS | 1684 | Values: 114.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:132.50 stddev:25.25 (19.1%) stddev-sans-first:26.05 04:46:07 INFO - PROCESS | 1684 | Values: 151.0 127.0 138.0 185.0 114.0 113.0 114.0 124.0 165.0 112.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.96 (1.1%) stddev-sans-first:2.07 04:46:07 INFO - PROCESS | 1684 | Values: 185.0 186.0 182.0 188.0 185.0 184.0 181.0 184.0 185.0 185.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:67.20 Median:62.50 stddev:10.62 (17.0%) stddev-sans-first:10.52 04:46:07 INFO - PROCESS | 1684 | Values: 78.0 61.0 62.0 90.0 63.0 62.0 61.0 59.0 77.0 59.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:84.50 stddev:12.81 (15.2%) stddev-sans-first:13.48 04:46:07 INFO - PROCESS | 1684 | Values: 87.0 71.0 88.0 69.0 71.0 93.0 108.0 84.0 68.0 85.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:98.60 Median:87.00 stddev:19.14 (22.0%) stddev-sans-first:19.99 04:46:07 INFO - PROCESS | 1684 | Values: 89.0 88.0 101.0 134.0 87.0 87.0 87.0 87.0 92.0 134.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:94.50 stddev:15.23 (16.1%) stddev-sans-first:15.96 04:46:07 INFO - PROCESS | 1684 | Values: 95.0 95.0 128.0 133.0 95.0 94.0 94.0 94.0 94.0 95.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.50 stddev:1.90 (2.2%) stddev-sans-first:1.94 04:46:07 INFO - PROCESS | 1684 | Values: 88.0 88.0 86.0 87.0 88.0 86.0 85.0 88.0 82.0 87.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 04:46:07 INFO - PROCESS | 1684 | Values: 64.0 62.0 63.0 61.0 64.0 63.0 64.0 62.0 63.0 63.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:61.00 stddev:4.68 (7.7%) stddev-sans-first:4.41 04:46:07 INFO - PROCESS | 1684 | Values: 56.0 57.0 68.0 70.0 67.0 61.0 60.0 60.0 61.0 61.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:89.50 stddev:1.78 (2.0%) stddev-sans-first:1.66 04:46:07 INFO - PROCESS | 1684 | Values: 91.0 86.0 90.0 87.0 86.0 89.0 88.0 90.0 89.0 90.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:142.00 stddev:13.63 (9.6%) stddev-sans-first:14.20 04:46:07 INFO - PROCESS | 1684 | Values: 139.0 142.0 142.0 141.0 139.0 140.0 139.0 142.0 182.0 157.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.10 Median:180.00 stddev:23.96 (13.3%) stddev-sans-first:25.37 04:46:07 INFO - PROCESS | 1684 | Values: 183.0 174.0 195.0 170.0 168.0 177.0 227.0 233.0 171.0 173.0 04:46:07 INFO - PROCESS | 1684 | 04:46:07 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 04:46:07 INFO - PROCESS | 1684 | Values: 67.0 67.0 66.0 67.0 66.0 66.0 65.0 67.0 66.0 66.0 04:46:07 INFO - PROCESS | 1684 | -------- Summary: end -------- 04:46:07 INFO - PROCESS | 1684 | 04:46:08 INFO - TEST-INFO | 1684: exit 0 04:46:08 INFO - TEST-OK | kraken | took 61530ms 04:46:08 INFO - SUITE-END | took 1182s 04:46:08 INFO - Completed test suite (00:19:42) 04:46:08 INFO - javascript benchmark 04:46:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7017.316296265259, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.224026233704, 3237.1745204972726, 3245.140037889959, 3249.9350012999726, 3274.1650879025847, 5436.809711660093, 5521.089020311644, 5602.663840169587, 5664.660120392774, 5689.943100568993, 5501.752421141048, 5560.916586251209, 5580.665160090387, 5625.071863142576, 5626.240457538231, 4117.300058989979, 5022.2968784370305, 5076.289319495274, 5089.185730283156, 5102.31118798963, 4683.437987441512, 5179.482051794809, 5204.661696989683, 5207.6354655174155, 5230.293910322096, 4981.078500477423, 5011.072951503984, 5042.722650254234, 5152.381714194321, 5158.742062896859, 3867.3812190049457, 5059.848204553869, 5065.062963351755, 5066.240063990394, 5143.996920600484, 5006.399232092136, 5013.774380152902, 5038.067957427851, 5046.545810877002, 5062.569681577033, 5480.205370221295, 5489.011977843987, 5498.395176530578, 5507.201455788888, 5523.447655234444, 6006.699665016776, 6010.158577799111, 6011.849703757397, 6013.9699301503215, 6016.217891674054, 6066.605670631395, 6100.115483254903, 6124.319907527348, 6139.26328840542, 6142.96928515359, 5568.248286481314, 5606.859828504279, 5639.520640745542, 5673.177389278531, 5683.9715801420725, 6286.308506064329, 6303.086052522451, 6303.527235457359, 6307.842303942438, 6313.273973493016, 5799.536037117021, 5830.7959221427045, 6033.969830150909, 6077.817665470043, 6099.725512351954, 6053.818385448443, 6080.908786368208, 6083.908741368883, 6087.512998960073, 6093.512518998469, 5942.168096466498, 5951.137085122719, 5976.491998180203, 5978.043513037893, 5979.312379076462, 5805.767769289266, 6009.699515024231, 6012.218411606463, 6028.2766068072115, 6050.848728781815, 4906.239532872411, 4913.21388577833, 4923.335349727741, 4962.255661650781, 4977.776000080005, 4296.570342965741, 4307.978460107679, 4338.089001309697, 4369.038811461473, 4506.616937560344, 5540.473655002768, 5626.718664066862, 5630.746616402272, 5644.491995720323, 5671.035923892948, 5042.294078828967, 5933.821985340447, 6004.489618382399, 6017.638941663514, 6202.0, 5497.285352904097, 5531.308586426697, 5554.694491802989, 5561.304836895388, 5564.749586268546, 3872.9031774205305, 4543.363929049936, 5319.148936170272, 5376.46235376467, 5435.755391007414, 6275.780347687809, 6300.716467758962, 6314.463270621956, 6327.303996560375, 6341.556091073673, 6213.2233470816145, 6241.157443745036, 6248.4688801452385, 6251.218597675291, 6260.561760676709, 6156.891759483336, 6216.564840461125, 6228.626282423069, 6265.467435267871, 6281.0, 5950.880982380415, 5997.850053748517, 6002.969985150046, 6017.518598512196, 6018.247719035121, 6020.367861374668, 6073.119397687399, 6080.8783824324155, 6084.087386892002, 6106.236720409949, 4526.932096018628, 5845.006348920779, 5853.912191317048, 5857.824265272048, 5859.531237501075, 4790.616750660009, 5743.994800909741, 5772.624779389326, 5776.480116789509, 5789.2763404574425, 5752.33848107473, 5772.711364431678, 5783.624064435799, 5787.36339002701, 5812.3025236971835, 5866.120081987736, 5870.031444811559, 5872.442117998783, 5873.442023007808, 5881.5588830837005, 5542.63972841764, 5710.771569137188, 5718.1708652246025, 5732.742026608896, 5735.598508104393], "value": 5517.055051134328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.795665170404, 778.3073064972176, 843.472829481574, 859.9097094805041, 860.0238729042538, 26206.47587048258, 27268.31829204271, 27301.59047614285, 36397.63602363975, 37154.814225928836, 37634.623653763454, 38024.42963355552, 38066.09975453802, 38101.0, 38136.42795358072, 8836.734897953056, 9001.414908030989, 9001.999999999967, 9007.1443212895, 9020.639174433014, 7177.85644287114, 7407.925920740804, 7409.70361185552, 8824.514651694186, 8959.955200224022, 7336.413086953057, 7373.078365204349, 10540.314879532843, 10750.731231719192, 10772.838407423895, 10655.307405018688, 10717.678469645924, 10735.892641073568, 10743.785124297548, 10748.570057197741, 10490.737731556696, 10544.367337959748, 10547.472626368652, 10549.41978191199, 10569.10162636177, 25349.0, 26061.478770424674, 35256.766013189415, 35817.64182358195, 35932.0, 3679.1168535432503, 3714.387126124186, 3754.662080412776, 3776.2825063237897, 3844.375388440025, 26074.087406940667, 26676.998450232426, 26741.180998845364, 26828.92684292626, 26923.0, 2934.7072524775913, 3004.263955330936, 3020.501617233154, 3080.337727388622, 3097.41149181657, 304191.0, 304270.47864760534, 304445.0, 305139.0, 305488.9999999978, 36958.0, 45580.77209613997, 45855.85360366017, 45874.85312867205, 45889.31166032512, 39965.80017099896, 40718.38922416166, 40722.77831665055, 42879.35680964788, 47545.81135471572, 10920.781584368267, 12084.0, 12168.939155304166, 12179.269243845398, 13368.598942031755, 11638.76722465546, 11696.532138714527, 11701.005414539859, 11701.531938722355, 11714.70713232159, 11143.33140011602, 11176.217664763552, 11192.160587955936, 11207.327560346243, 11222.607208747655, 4360.055010869071, 5104.243708397424, 5104.2993829473335, 5105.595961110725, 5116.718580478109, 1008.8537162111453, 1027.671145233518, 1091.956321747137, 1123.730304726876, 1157.0685598093448, 22155.0, 24285.7571424287, 25257.24228273118, 25433.745662543508, 25512.872435637702, 1186.1993154620598, 1199.1186477938709, 1221.4137214137263, 1227.7851376009341, 1251.9436625351882, 13015.804762928563, 13241.668958276121, 13271.938244940382, 13289.734205315839, 13300.268485233211, 394705.0, 394721.0, 394978.0, 396385.0, 397481.0, 50498.0, 50505.494945050814, 50599.24101138486, 50715.23927141096, 50720.23919641208, 1380.9723805523834, 1408.3028900694017, 1411.1533080152033, 1415.2287003582867, 1419.7302512522588, 23121.047066100415, 23987.225327176842, 24610.261692149263, 24777.88499517562, 24839.751602483742, 41125.79437102795, 41379.7931010343, 41383.37924931068, 41409.0, 41409.1718165641, 282304.0, 283234.0, 283541.0, 283869.0, 284264.0, 30358.392832143676, 31018.53472197964, 31049.0, 31073.0, 31077.844610776803, 28230.43539129247, 37501.6249837509, 37986.62013379941, 38134.618653814214, 38268.61731382651, 32244.032679019667, 32399.51400728944, 32751.0, 33828.66171338255, 34070.82964585161, 32401.0, 32545.511817323233, 32653.346933061683, 33689.494657579664, 33729.0, 26744.866275668497, 33143.00570982874, 33175.17062073467, 33197.33605327832, 33271.50092748562, 26713.866430667724, 26941.461170776867, 28463.0, 29180.416391672472, 29513.85243073771, 21397.823119728564, 21654.133834646436, 22466.213682521033, 22626.98178581935, 22664.433389164744], "value": 17127.88150856752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.49881426082277, 362.7214070401833, 390.8202226975591, 401.3097472347563, 418.88480667816344, 13521.25633090181, 13759.31203439829, 14850.628734281649, 20404.693929591067, 21267.255646052392, 17748.46754597361, 21461.248856290033, 21814.563708725815, 22410.88794556029, 22677.773222267773, 5881.617694849831, 5982.102684597302, 6007.429294217042, 6141.846453838645, 6150.938490615104, 5983.611065280765, 6066.545009124311, 6102.633841969496, 6128.662923539204, 6136.570440069197, 3856.9807150964207, 4008.4588580541545, 4041.1715598302276, 4046.7571945683208, 6354.9364506354805, 6523.836904077389, 6615.0, 6627.204735431755, 6756.662166891685, 6766.221884483273, 5869.882602347971, 5874.823755287348, 5878.647281163101, 5880.117982302646, 5883.646981181143, 25489.0, 26105.869470652717, 26169.214923552325, 26210.73789262121, 26572.601410978852, 2675.7859371250447, 2734.0, 2753.559430491132, 2758.4207316463567, 2772.002079251468, 10070.446125463097, 10325.225608079425, 10422.739431514197, 12408.503659853684, 14111.0, 1419.304540775023, 1776.4936992957075, 1795.7396177554313, 1822.307523141211, 1943.1741509858396, 120103.3994830029, 125872.0, 125892.0, 126870.0, 126896.99999999908, 11307.208495405243, 11766.705832354259, 11813.468393922294, 11840.072425974871, 11864.940675296568, 15929.362825487082, 15941.282642281125, 15951.680966380607, 15957.361705531881, 15990.840091599168, 8403.537805420638, 8596.484210947363, 8650.783730406665, 8724.258438032712, 8728.301735861116, 6923.2038315593345, 8123.675052997932, 8150.796230094295, 8185.503421456394, 8336.124706905808, 4694.155052090657, 4784.545468180518, 4809.495003024702, 4843.1524483216, 4897.730624815598, 1685.578605348663, 1804.9909750451427, 1825.7352683860765, 1910.6274276516224, 2051.8050785175383, 1007.8337074382645, 1022.8312328465869, 1037.3620223562455, 1079.3092420850662, 1092.9617463388743, 20366.89816550908, 21815.127394904026, 21857.3606979474, 22032.559348813254, 22099.889500552395, 963.5182408795603, 966.8694726212012, 982.0, 1080.8811030786608, 1097.6048622495896, 10751.946240268748, 11027.897210278908, 11265.54937802495, 11537.48081336342, 11600.88399116015, 385113.0, 493332.0, 581730.0, 595676.0, 596132.0, 131684.3415782915, 131911.3404432991, 134680.32659836835, 134731.0, 135369.3231533836, 984.8276551603441, 997.2321312589411, 1025.2566889005411, 1029.7477118105962, 1030.062642994871, 19014.524636884187, 19183.904080479508, 19369.934653594188, 19414.0, 19438.8056119437, 54809.72595136999, 55458.44541554533, 56023.719881400335, 56798.86402271849, 56993.43006570047, 58712.0, 77878.6106069466, 79808.60095699716, 79814.80277795954, 79913.0, 8229.341652667892, 8286.958565207135, 8431.704890329054, 8502.489850608983, 8504.574771261536, 12846.229226246454, 12914.741705166032, 13332.066755327034, 13338.26639534796, 13437.596872093853, 10829.945850271013, 11222.943885280521, 11401.429928503376, 11404.82892756626, 11423.657290281304, 10496.422696751752, 10910.072643825364, 11024.669259922215, 11228.4385780709, 11270.380129092979, 10999.395033273247, 11188.66434006981, 11488.080953523866, 12033.097517686383, 12109.212901161749, 8244.917550824415, 8541.743747687578, 8542.78643033929, 8588.699395521127, 8684.088170741981, 11331.263467874562, 11446.713832154262, 11719.06247500215, 11808.70478238051, 11876.287422754662], "value": 9766.331258170276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.5455981365862, 1444.1335198880672, 1458.67179884526, 1466.428093043713, 1472.168224952902, 8327.292180164686, 8723.738287851358, 8730.388872778907, 8730.825383492327, 8737.038925718165, 8319.708810191645, 8567.228949394568, 8614.827703445928, 8623.784405389853, 8630.223279904807, 2266.252136794854, 2308.480591866825, 2310.792028717415, 2311.7919387255142, 2314.7569505201964, 2267.047839907243, 2304.193532263711, 2306.8039216666602, 2308.0, 2311.3181611424584, 2259.062489067035, 2260.9321720348416, 2280.6579013147993, 2281.4182383492184, 2284.6116160252714, 2242.6411774116227, 2244.450109723112, 2261.920832770845, 2266.9206577769864, 2268.3648578398074, 1857.349927525369, 2260.6156953317977, 2262.725960409794, 2262.8615957919774, 2264.105678257079, 8641.783955401103, 8705.260052895512, 8714.477131372138, 8716.694915677921, 8732.12678732128, 5113.386393632788, 5276.868078298074, 5279.41926388097, 5282.498162674539, 5289.418164001957, 3276.737860971117, 3356.664333566648, 3507.14075051614, 3572.2855428914063, 3572.91067723309, 998.5356809083811, 1208.112037652325, 1218.3299185448057, 1224.7489264700714, 1239.8884100431005, 10152.289339746221, 10467.685969420929, 10491.895081049244, 10955.233133680646, 10974.341539507655, 4333.836299501381, 4482.7758612069265, 4487.775611219426, 4507.346434766941, 4518.683692141584, 8887.644494220289, 8901.421407608485, 8904.421212621159, 8911.37620366581, 8918.821623567492, 4465.196264672325, 4627.8611641650805, 4635.6986795858165, 5171.146760784503, 5171.172612382001, 4651.209294419957, 4815.22956326986, 4856.1016212000895, 4871.610271178297, 4877.902441951142, 3474.530938323294, 3511.736619753529, 3549.290141971616, 3606.2607165531003, 3622.0, 1081.6917178604217, 1091.2743025887696, 1106.1482658353184, 1107.7064577886867, 1114.7268919114706, 762.4281788658507, 843.6920524008815, 891.7547674389594, 893.2005854759954, 938.957746901391, 5347.144456886879, 5406.432324605938, 5662.405447428043, 5771.451712087345, 5809.680467574324, 881.6605606841413, 955.7610597350663, 993.6621548673486, 998.1964518562627, 1027.6916924922493, 3700.3709369407266, 3715.3126671565306, 3814.732968692165, 3860.1314704191896, 3889.824957876846, 9672.516374181403, 9685.128338449573, 9852.014798520235, 9861.309708320348, 9866.358686685342, 9785.559649815776, 9813.11681948628, 9816.165625921734, 9818.41089534616, 9821.312508124505, 7396.741114061089, 7780.416468764865, 8016.398770092266, 8024.358051355877, 8044.316233120133, 4816.638752093677, 5502.422245664307, 5789.8552536186935, 5830.212921255746, 5833.125031245348, 8985.371024028254, 9084.0, 9295.535223238676, 9416.199623032118, 9522.904770952202, 9109.089091090838, 9400.76498087526, 9498.14516693501, 9534.951155372764, 9541.141297283279, 7183.712651493882, 7322.1579518356075, 7433.516821406592, 7435.182129965808, 7439.442041846775, 7885.921140788748, 7964.831651513684, 7974.003249593801, 8041.67833286662, 8048.798780030312, 7171.892421613576, 7244.637768111679, 7305.1233851938105, 7312.890306645511, 7315.195328513752, 6997.230304666381, 7104.609246491493, 7117.537360071578, 7146.392556632744, 7190.245024272376, 6388.680565971776, 6505.121808555974, 6513.478921686159, 6515.934840651533, 6521.054447105238, 3899.3886045447166, 4622.86131416058, 4848.0, 5077.111505486451, 5087.364079490064, 4861.4895435980125, 4925.48282430354, 5000.64995450315, 5022.397312322545, 5216.921746173886], "value": 4393.236140684163, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.7707776473233, 338.85937336005543, 340.2446568617669, 346.2617659350061, 367.97792132472034, 4421.734695918243, 4618.861434156972, 5118.539331460172, 5270.183121616146, 5358.651687640306, 4832.903341933168, 5320.680759154454, 5347.0909945309295, 5351.25082488452, 5352.2239275305055, 3526.0, 4191.643710284629, 4219.0, 4224.260754367989, 4259.275923093066, 3801.4414090223013, 3923.941140882889, 3999.6600288975474, 4081.4082507821972, 4235.1529694061155, 3945.2504024235304, 3993.3011722948513, 4009.4363198352667, 4018.2967980603426, 4031.3549832026733, 3982.303096958021, 3993.900152496182, 4007.338789099795, 4027.5230733099224, 4033.878983630496, 3472.4791281307753, 3495.846370697689, 3503.6146023937345, 3507.4563442666426, 3517.718582513393, 4449.822007119711, 4667.766611669403, 5158.587313014949, 5225.529702326771, 5268.288781014552, 3710.7959062251566, 3717.739758216926, 4407.427034485529, 4471.904383426049, 4611.400517932647, 5330.706811125387, 5643.871225754865, 5644.915326270109, 5645.294338207724, 5685.862827434488, 3229.9677003229904, 3769.359208934488, 3798.2783271178387, 3802.790846503441, 3824.8661296854757, 5420.024395608789, 5532.446755324516, 5751.683657398799, 5829.533637309005, 5932.406759324076, 3722.571904231048, 4102.933237358248, 4126.442930204384, 4153.7507749535125, 4224.366345048267, 3639.5632524097277, 4274.0339443855555, 4289.134226611434, 4298.6131248187185, 4325.221460137205, 4553.0, 4615.561521655437, 4664.486906440289, 4719.551642593948, 4887.926681099786, 5245.475452454724, 5456.945430545723, 5682.0, 5693.363570065605, 5812.912806307909, 1228.2753175626424, 1272.9299888506036, 1358.7622166120889, 1376.0917794255743, 1400.8233084209312, 786.7049856303886, 871.5947084605561, 878.9912100879037, 931.3154831199063, 980.3333733061444, 4381.816909434435, 5042.663694121061, 5073.528676683721, 5083.593312534988, 5103.478599766149, 5159.484051594885, 5479.150731636602, 5563.888722225533, 5576.9163462548095, 5624.959382514248, 4033.38659573836, 4698.003348576841, 4778.95221047792, 4971.254311853251, 5083.974580127149, 2604.9088281910044, 2703.337682267818, 2719.6600424946882, 2907.941841163165, 2919.5182794838615, 5402.810901618424, 5450.29146210998, 5635.69003704792, 5706.28671416073, 5735.283089613798, 5025.170846810235, 5284.524392804589, 5626.521745651666, 5678.5741069419955, 5748.7125643717645, 4824.252240902595, 5230.555402790729, 5361.12360673761, 5442.2108794225405, 5755.597108202385, 5000.599952003904, 5339.985402773461, 5530.28561146046, 5544.584156188222, 5550.916736249041, 4818.759062046954, 4921.163402221559, 5010.599152067899, 5474.698891561003, 5495.560355171497, 5613.354464236665, 5661.122526008476, 5689.0, 5712.714364281686, 5820.679862607597, 3549.6095429502216, 3999.3401088821183, 4056.634902858757, 4165.14614504032, 4176.373543968429, 5795.304563452412, 5795.623284486495, 5820.650760954356, 5826.563007774519, 5857.912131318119, 3968.861089861841, 5442.42169770762, 5611.747471363717, 5649.350324712711, 5691.430856914276, 5288.836455979678, 5364.490373414519, 5650.23721797552, 5663.375439718666, 5668.773249069991, 5205.735505055313, 5263.894582137794, 5323.547498462674, 5548.334199896039, 5568.470995255444, 5404.567634589145, 5568.77724891016, 5642.956053130184, 5657.490825825531, 5659.943400565941, 5507.366652834815, 5522.134505846004, 5529.921665275233, 5532.834014979557, 5534.723263836872], "value": 4089.886088287502, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.8331850400389, 754.8037510247337, 766.2337662337659, 826.3182874128844, 828.5732847583494, 14304.856951430482, 15051.849481505182, 15052.849471505282, 15054.623634409145, 15062.020968637045, 13822.101563398372, 13914.165150091001, 13930.721385572282, 13931.791023134636, 13936.0, 823.7034667519688, 922.9261659067292, 925.6436272035264, 938.451006161393, 942.3026960049583, 939.5865819039601, 954.1031430455384, 954.5322791831987, 956.8421210500259, 957.2533423929347, 988.9505524723735, 990.5443495991852, 990.9256805739562, 992.8113658404916, 993.2897977945768, 852.1521086518953, 984.4044353166303, 988.6440881282732, 989.1888651305932, 989.6931951095183, 732.3445516262915, 732.5128789355126, 733.0763238319755, 733.2154594583798, 733.7248531800575, 15117.244137793066, 15357.308921098578, 15450.381984720598, 15476.922615386851, 15666.608334791608, 13836.930815345959, 14024.579262622137, 14062.789058164135, 14135.575932722035, 14208.92895535526, 9835.360701554448, 11681.299122052704, 11699.649010529698, 12011.339376334297, 12176.26942383451, 3566.554180727409, 3628.2562074774874, 3632.673059424638, 3639.672429481333, 3664.3404187246283, 96136.51931740367, 97421.0, 98369.0, 99100.0, 100797.48803767949, 10614.416207108683, 10616.469176541143, 10683.0, 10695.94652026735, 11053.944730276296, 22553.0, 23019.654705179437, 23020.539589208456, 23032.539349212922, 23156.0, 7345.853082938418, 7397.334239918433, 7451.701931922662, 7470.402367810562, 7537.2462753725285, 3947.190825880745, 4027.4160246764054, 4120.896977575585, 4172.144710334374, 4249.128928569636, 3454.9818145829627, 3585.372559802024, 3590.7127429805555, 3591.2996965591983, 3591.353556359828, 680.7753441364338, 686.4508393285452, 695.4818660098158, 730.837789661317, 740.2301606329464, 645.8320836582428, 668.5086461450829, 670.7969445895886, 699.7166147710185, 700.3136925812732, 9601.951990240004, 9722.562484688206, 9887.901120988698, 10035.548400322003, 10122.443265620313, 650.5992886249724, 674.7264488810629, 681.32208452589, 713.8286811165386, 728.4099879097947, 4101.835926562904, 4565.680402371869, 4568.132054909556, 4839.564439200419, 4849.515048495122, 81896.0, 84303.0, 96027.55958660625, 97436.0, 98068.0, 54644.72677636586, 68968.27579310557, 70812.22969425806, 79047.0, 84290.15709842945, 70795.64602176956, 71751.64124179346, 72905.0, 73406.63296683696, 74508.25491745121, 9114.635414583343, 9240.168384845396, 9306.115918987685, 9420.0, 9452.480113593818, 36475.817620912785, 47783.761081194374, 49356.0, 49529.0, 49765.0, 46028.794241151234, 50040.748981275756, 61497.38502614917, 62643.74712505633, 64808.67595661992, 11248.831267531157, 11377.658670239905, 11859.05127589808, 11985.940070299594, 11992.220505667452, 11809.23239989398, 11958.342291174069, 11971.319748997998, 12024.75950480968, 12182.512699492276, 11248.212625116163, 11450.146248283994, 11905.404729763304, 11907.761844762883, 12041.397930103285, 11433.314001159957, 11609.5356185755, 11934.403279836148, 12034.939825300817, 12043.578474753342, 8325.666973321, 11110.722231944266, 11742.706432338919, 12114.273143611412, 12360.814587781011, 9469.402404737517, 9491.335606507479, 9507.239420846177, 9562.617495300388, 9834.311598188058, 6704.698288577123, 8399.496030238206, 8687.782805429662, 9719.56261968199, 10600.259878623714], "value": 7200.216889175347, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 138.0, 185.0, 114.0, 113.0, 114.0, 124.0, 165.0, 112.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 182.0, 188.0, 185.0, 184.0, 181.0, 184.0, 185.0, 185.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 61.0, 62.0, 90.0, 63.0, 62.0, 61.0, 59.0, 77.0, 59.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 88.0, 69.0, 71.0, 93.0, 108.0, 84.0, 68.0, 85.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 101.0, 134.0, 87.0, 87.0, 87.0, 87.0, 92.0, 134.0], "value": 98.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 128.0, 133.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 87.0, 88.0, 86.0, 85.0, 88.0, 82.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 61.0, 64.0, 63.0, 64.0, 62.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 68.0, 70.0, 67.0, 61.0, 60.0, 60.0, 61.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 90.0, 87.0, 86.0, 89.0, 88.0, 90.0, 89.0, 90.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 142.0, 141.0, 139.0, 140.0, 139.0, 142.0, 182.0, 157.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 174.0, 195.0, 170.0, 168.0, 177.0, 227.0, 233.0, 171.0, 173.0], "value": 187.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0], "value": 66.3, "unit": "score"}]}]} 04:46:09 INFO - Return code: 0 04:46:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:46:09 ERROR - # TBPL SUCCESS # 04:46:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:09 INFO - 2017-02-27 04:46:09.147 screenresolution[1688:12640] starting screenresolution argv=screenresolution get 04:46:09 INFO - 2017-02-27 04:46:09.150 screenresolution[1688:12640] Display 0: 1600x1200x32@60 04:46:09 INFO - 2017-02-27 04:46:09.156 screenresolution[1689:12643] starting screenresolution argv=screenresolution list 04:46:09 INFO - Available Modes on Display 0 04:46:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:09 INFO - Intel Iris: 04:46:09 INFO - Chipset Model: Intel Iris 04:46:09 INFO - Type: GPU 04:46:09 INFO - Bus: Built-In 04:46:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:09 INFO - Vendor: Intel (0x8086) 04:46:09 INFO - Device ID: 0x0a2e 04:46:09 INFO - Revision ID: 0x0009 04:46:09 INFO - Displays: 04:46:09 INFO - Display: 04:46:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:09 INFO - Display Serial Number: 1600x1200 60 04:46:09 INFO - Main Display: Yes 04:46:09 INFO - Mirror: Off 04:46:09 INFO - Online: Yes 04:46:09 INFO - Rotation: Supported 04:46:09 INFO - Return code: 0 04:46:09 INFO - Running post-action listener: _resource_record_post_action 04:46:09 INFO - [mozharness: 2017-02-27 12:46:09.393834Z] Finished run-tests step (success) 04:46:09 INFO - Running post-run listener: _resource_record_post_run 04:46:09 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 33004544; Write bytes: 513631232; Read time: 309; Write time: 2133 04:46:09 INFO - TinderboxPrint: CPU usage
53.8% 04:46:09 INFO - TinderboxPrint: I/O read bytes / time
33,004,544 / 309 04:46:09 INFO - TinderboxPrint: I/O write bytes / time
513,631,232 / 2,133 04:46:09 INFO - TinderboxPrint: CPU idle
2,222.1 (46.2%) 04:46:09 INFO - TinderboxPrint: CPU system
959.4 (19.9%) 04:46:09 INFO - TinderboxPrint: CPU user
1,632.3 (33.9%) 04:46:09 INFO - TinderboxPrint: Swap in / out
239,271,936 / 0 04:46:09 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200874496; Write bytes: 197015552; Read time: 15379; Write time: 462 04:46:09 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 32082944; Write bytes: 298220544; Read time: 294; Write time: 1612 04:46:09 INFO - Running post-run listener: _upload_blobber_files 04:46:09 INFO - Blob upload gear active. 04:46:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:09 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 04:46:09 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'] 04:46:09 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 04:46:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:11 INFO - (blobuploader) - INFO - Done attempting. 04:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:12 INFO - (blobuploader) - INFO - Done attempting. 04:46:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:46:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:13 INFO - (blobuploader) - INFO - Done attempting. 04:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:15 INFO - (blobuploader) - INFO - Done attempting. 04:46:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:15 INFO - Return code: 0 04:46:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d60636b4021e2ce2ab44ea731df59aaa54c7ca5feb294fbaf31aa86dfef866e1dd4685d0de45d92f0aaa4a345b4c85f867fdfa9d2e221dcb5f3d2c766a5d96a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb07927be101233e69181efa23952c2c0f21c8d5888a226a0f9dcd0ddbbbd6bc2a6db1ab29aa54eb4bb06d782033dd52e554fe6910772ff04b98561a09385637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71034b3ecc4f86cc8eaefc996e4bfa30feea27bddcf1334eb918b1ceb3897630d4f0e9658c030470fae036f6dd3f22da86b71d48b7d79759dc3bc30ec5707cca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8e445cdef65d5f3dfe10d5173b469b81d2e15737f7267478112b252fcb3de9226494ada4c38470aa5f698162f4b61737990cb1ae145589bb899ed1271818646"} 04:46:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:15 INFO - Contents: 04:46:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d60636b4021e2ce2ab44ea731df59aaa54c7ca5feb294fbaf31aa86dfef866e1dd4685d0de45d92f0aaa4a345b4c85f867fdfa9d2e221dcb5f3d2c766a5d96a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb07927be101233e69181efa23952c2c0f21c8d5888a226a0f9dcd0ddbbbd6bc2a6db1ab29aa54eb4bb06d782033dd52e554fe6910772ff04b98561a09385637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71034b3ecc4f86cc8eaefc996e4bfa30feea27bddcf1334eb918b1ceb3897630d4f0e9658c030470fae036f6dd3f22da86b71d48b7d79759dc3bc30ec5707cca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8e445cdef65d5f3dfe10d5173b469b81d2e15737f7267478112b252fcb3de9226494ada4c38470aa5f698162f4b61737990cb1ae145589bb899ed1271818646"} 04:46:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:15 INFO - Copying logs to upload dir... 04:46:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.647888 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-27 04:46:15.554814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 04:46:15.558463) ========= 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.IEFttHDA6d/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.9bgTrhYySD/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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/d60636b4021e2ce2ab44ea731df59aaa54c7ca5feb294fbaf31aa86dfef866e1dd4685d0de45d92f0aaa4a345b4c85f867fdfa9d2e221dcb5f3d2c766a5d96a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb07927be101233e69181efa23952c2c0f21c8d5888a226a0f9dcd0ddbbbd6bc2a6db1ab29aa54eb4bb06d782033dd52e554fe6910772ff04b98561a09385637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71034b3ecc4f86cc8eaefc996e4bfa30feea27bddcf1334eb918b1ceb3897630d4f0e9658c030470fae036f6dd3f22da86b71d48b7d79759dc3bc30ec5707cca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8e445cdef65d5f3dfe10d5173b469b81d2e15737f7267478112b252fcb3de9226494ada4c38470aa5f698162f4b61737990cb1ae145589bb899ed1271818646"} build_url:https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/dGhOHNQpQEi88xOcLftxfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d60636b4021e2ce2ab44ea731df59aaa54c7ca5feb294fbaf31aa86dfef866e1dd4685d0de45d92f0aaa4a345b4c85f867fdfa9d2e221dcb5f3d2c766a5d96a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb07927be101233e69181efa23952c2c0f21c8d5888a226a0f9dcd0ddbbbd6bc2a6db1ab29aa54eb4bb06d782033dd52e554fe6910772ff04b98561a09385637", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71034b3ecc4f86cc8eaefc996e4bfa30feea27bddcf1334eb918b1ceb3897630d4f0e9658c030470fae036f6dd3f22da86b71d48b7d79759dc3bc30ec5707cca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8e445cdef65d5f3dfe10d5173b469b81d2e15737f7267478112b252fcb3de9226494ada4c38470aa5f698162f4b61737990cb1ae145589bb899ed1271818646"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 04:46:15.593247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 04:46:15.593558) ========= 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.IEFttHDA6d/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.9bgTrhYySD/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.005187 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 04:46:15.641882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 04:46:15.642234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 04:46:15.642545) ========= ========= Total master_lag: 0.20 =========