builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0220 starttime: 1489331306.66 results: success (0) buildid: 20170312072936 builduid: 61f25951d46343a39ba7d3236d5a8a98 revision: d173b2b2852fde503b1e42875982ad023ab3ad8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:26.664913) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:26.665397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:26.665682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:26.703529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:26.704084) ========= 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.6V8sE6UIm8/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.hm3UjrukdN/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-03-12 08:08:26-- 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% 18.8M=0.001s 2017-03-12 08:08:27 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.635824 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:27.364985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:27.365357) ========= 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.6V8sE6UIm8/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.hm3UjrukdN/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.025610 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:27.414056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-12 08:08:27.414406) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d173b2b2852fde503b1e42875982ad023ab3ad8b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d173b2b2852fde503b1e42875982ad023ab3ad8b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6V8sE6UIm8/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.hm3UjrukdN/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-03-12 08:08:27,520 truncating revision to first 12 chars 2017-03-12 08:08:27,520 Setting DEBUG logging. 2017-03-12 08:08:27,521 attempt 1/10 2017-03-12 08:08:27,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d173b2b2852f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-12 08:08:28,650 unpacking tar archive at: mozilla-aurora-d173b2b2852f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.403088 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-12 08:08:28.841898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:28.842223) ========= script_repo_revision: d173b2b2852fde503b1e42875982ad023ab3ad8b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:28.842673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:28.842943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-12 08:08:28.863181) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-12 08:08:28.863595) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6V8sE6UIm8/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.hm3UjrukdN/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:08:29 INFO - MultiFileLogger online at 20170312 08:08:29 in /builds/slave/test 08:08:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:08:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:29 INFO - {'append_to_log': False, 08:08:29 INFO - 'base_work_dir': '/builds/slave/test', 08:08:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:08:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:29 INFO - 'branch': 'Mozilla-Aurora', 08:08:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:29 INFO - 'config_files': ('talos/mac_config.py',), 08:08:29 INFO - 'default_actions': ('clobber', 08:08:29 INFO - 'read-buildbot-config', 08:08:29 INFO - 'download-and-extract', 08:08:29 INFO - 'populate-webroot', 08:08:29 INFO - 'create-virtualenv', 08:08:29 INFO - 'install', 08:08:29 INFO - 'run-tests'), 08:08:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:29 INFO - 'download_minidump_stackwalk': True, 08:08:29 INFO - 'download_symbols': 'ondemand', 08:08:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:29 INFO - 'gecko_profile': False, 08:08:29 INFO - 'gecko_profile_interval': 0, 08:08:29 INFO - 'installer_path': 'installer.exe', 08:08:29 INFO - 'log_level': 'info', 08:08:29 INFO - 'log_name': 'talos', 08:08:29 INFO - 'log_to_console': True, 08:08:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:08:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:08:29 INFO - 'opt_config_files': (), 08:08:29 INFO - 'pip_index': False, 08:08:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:29 INFO - 'cmd': ('bash', 08:08:29 INFO - '-c', 08:08:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:29 INFO - 'enabled': True, 08:08:29 INFO - 'halt_on_failure': False, 08:08:29 INFO - 'name': 'check_screen_resolution'},), 08:08:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:29 INFO - 'cmd': ('bash', 08:08:29 INFO - '-c', 08:08:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:29 INFO - 'enabled': True, 08:08:29 INFO - 'halt_on_failure': False, 08:08:29 INFO - 'name': 'check_screen_resolution'},), 08:08:29 INFO - 'run_cmd_checks_enabled': True, 08:08:29 INFO - 'suite': 'dromaeojs-e10s', 08:08:29 INFO - 'system_bits': '32', 08:08:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:29 INFO - 'title': 't-yosemite-r7-0220', 08:08:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:29 INFO - 'use_talos_json': True, 08:08:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:29 INFO - 'work_dir': 'build'} 08:08:29 INFO - [mozharness: 2017-03-12 15:08:29.074210Z] Running clobber step. 08:08:29 INFO - Running pre-action listener: _resource_record_pre_action 08:08:29 INFO - Running main action method: clobber 08:08:29 INFO - rmtree: /builds/slave/test/build 08:08:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:31 INFO - Running post-action listener: _resource_record_post_action 08:08:31 INFO - [mozharness: 2017-03-12 15:08:31.543073Z] Finished clobber step (success) 08:08:31 INFO - [mozharness: 2017-03-12 15:08:31.543204Z] Running read-buildbot-config step. 08:08:31 INFO - Running pre-action listener: _resource_record_pre_action 08:08:31 INFO - Running main action method: read_buildbot_config 08:08:31 INFO - Using buildbot properties: 08:08:31 INFO - { 08:08:31 INFO - "project": "", 08:08:31 INFO - "product": "firefox", 08:08:31 INFO - "script_repo_revision": "production", 08:08:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:08:31 INFO - "repository": "", 08:08:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:08:31 INFO - "buildid": "20170312072936", 08:08:31 INFO - "pgo_build": "False", 08:08:31 INFO - "basedir": "/builds/slave/test", 08:08:31 INFO - "buildnumber": 10, 08:08:31 INFO - "slavename": "t-yosemite-r7-0220", 08:08:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:08:31 INFO - "platform": "yosemite_r7", 08:08:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:08:31 INFO - "branch": "mozilla-aurora", 08:08:31 INFO - "repo_path": "releases/mozilla-aurora", 08:08:31 INFO - "revision": "d173b2b2852fde503b1e42875982ad023ab3ad8b", 08:08:31 INFO - "stage_platform": "macosx64", 08:08:31 INFO - "builduid": "61f25951d46343a39ba7d3236d5a8a98", 08:08:31 INFO - "slavebuilddir": "test" 08:08:31 INFO - } 08:08:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 08:08:31 INFO - Running post-action listener: _resource_record_post_action 08:08:31 INFO - [mozharness: 2017-03-12 15:08:31.546787Z] Finished read-buildbot-config step (success) 08:08:31 INFO - [mozharness: 2017-03-12 15:08:31.546908Z] Running download-and-extract step. 08:08:31 INFO - Running pre-action listener: _resource_record_pre_action 08:08:31 INFO - Running main action method: download_and_extract 08:08:31 INFO - mkdir: /builds/slave/test/build/tests 08:08:31 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')]} 08:08:31 INFO - trying https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 08:08:31 INFO - Downloading https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 08:08:32 INFO - Downloaded 1199 bytes. 08:08:32 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:08:32 INFO - Using the following test package requirements: 08:08:32 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:08:32 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 08:08:32 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 08:08:32 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'jsshell-mac.zip'], 08:08:32 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 08:08:32 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:08:32 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 08:08:32 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 08:08:32 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 08:08:32 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:08:32 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 08:08:32 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:08:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:08:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:08:32 INFO - Fetch https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:08:34 INFO - Expected file size: 51779041 08:08:34 INFO - Obtained file size: 51779041 08:08:50 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:08:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:08:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:08:50 INFO - Fetch https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:08:52 INFO - Expected file size: 51779041 08:08:52 INFO - Obtained file size: 51779041 08:09:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 08:09:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:09:07 INFO - Fetch https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 08:09:08 INFO - Expected file size: 14404424 08:09:08 INFO - Obtained file size: 14404424 08:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:08 INFO - trying https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:09:08 INFO - Downloading https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 08:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 08:09:10 INFO - Downloaded 74620497 bytes. 08:09:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:09:10 INFO - mkdir: /builds/slave/test/properties 08:09:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:10 INFO - Contents: 08:09:10 INFO - build_url:https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:09:11 INFO - Running post-action listener: _resource_record_post_action 08:09:11 INFO - Running post-action listener: set_extra_try_arguments 08:09:11 INFO - [mozharness: 2017-03-12 15:09:11.555082Z] Finished download-and-extract step (success) 08:09:11 INFO - [mozharness: 2017-03-12 15:09:11.555234Z] Running populate-webroot step. 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: populate_webroot 08:09:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:11 INFO - '--tppagecycles', 08:09:11 INFO - '7'], 08:09:11 INFO - 'tests': ['tsvgm']}}, 08:09:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:09:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['damp', 'tps']}, 08:09:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:09:11 INFO - 'tests': ['damp', 'tps']}, 08:09:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['dromaeo_dom']}, 08:09:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['basic_compositor_video']}, 08:09:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:09:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tsvgx', 08:09:11 INFO - 'tsvgr_opacity', 08:09:11 INFO - 'tart', 08:09:11 INFO - 'tscrollx', 08:09:11 INFO - 'cart', 08:09:11 INFO - 'tsvg_static']}, 08:09:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:11 INFO - 'tsvgr_opacity', 08:09:11 INFO - 'tart', 08:09:11 INFO - 'tscrollx', 08:09:11 INFO - 'cart', 08:09:11 INFO - 'tsvg_static']}, 08:09:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tp5o']}, 08:09:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:09:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s', 08:09:11 INFO - '--xperf_path', 08:09:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:11 INFO - 'tests': ['tp5n']}, 08:09:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:09:11 INFO - 'talos_options': ['--xperf_path', 08:09:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:11 INFO - 'tests': ['tp5n']}}, 08:09:11 INFO - 'talos.zip': {'path': '', 08:09:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:11 INFO - Running post-action listener: _resource_record_post_action 08:09:11 INFO - [mozharness: 2017-03-12 15:09:11.573675Z] Finished populate-webroot step (success) 08:09:11 INFO - [mozharness: 2017-03-12 15:09:11.573806Z] Running create-virtualenv step. 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: create_virtualenv 08:09:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:11 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 08:09:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:11 INFO - Using real prefix '/tools/python27' 08:09:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:15 INFO - Installing pip.................done. 08:09:15 INFO - Return code: 0 08:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:09:15 INFO - Reading from file tmpfile_stdout 08:09:15 INFO - Output received: 08:09:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:09:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:15 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')]} 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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')]} 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:15 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 08:09:15 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 08:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:15 INFO - 'HOME': '/Users/cltbld', 08:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:15 INFO - 'LOGNAME': 'cltbld', 08:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:15 INFO - 'MOZ_NO_REMOTE': '1', 08:09:15 INFO - 'NO_EM_RESTART': '1', 08:09:15 INFO - 'PAGER': '/bin/cat', 08:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:15 INFO - 'PWD': '/builds/slave/test', 08:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:15 INFO - 'SHELL': '/bin/bash', 08:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:15 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:15 INFO - 'USER': 'cltbld', 08:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:15 INFO - 'XPC_FLAGS': '0x0', 08:09:15 INFO - 'XPC_SERVICE_NAME': '0', 08:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:15 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 08:09:15 INFO - Cleaning up... 08:09:15 INFO - Return code: 0 08:09:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:15 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')]} 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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')]} 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:15 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 08:09:15 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 08:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:15 INFO - 'HOME': '/Users/cltbld', 08:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:15 INFO - 'LOGNAME': 'cltbld', 08:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:15 INFO - 'MOZ_NO_REMOTE': '1', 08:09:15 INFO - 'NO_EM_RESTART': '1', 08:09:15 INFO - 'PAGER': '/bin/cat', 08:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:15 INFO - 'PWD': '/builds/slave/test', 08:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:15 INFO - 'SHELL': '/bin/bash', 08:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:15 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:15 INFO - 'USER': 'cltbld', 08:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:15 INFO - 'XPC_FLAGS': '0x0', 08:09:15 INFO - 'XPC_SERVICE_NAME': '0', 08:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:16 INFO - Downloading/unpacking psutil>=3.1.1 08:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:20 INFO - Installing collected packages: psutil 08:09:20 INFO - Running setup.py install for psutil 08:09:20 INFO - building 'psutil._psutil_osx' extension 08:09:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:09:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:09:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:09:20 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 08:09:20 INFO - building 'psutil._psutil_posix' extension 08:09:20 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 08:09:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:09:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:09:20 INFO - ^ 08:09:21 INFO - 1 warning generated. 08:09:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:21 INFO - Successfully installed psutil 08:09:21 INFO - Cleaning up... 08:09:21 INFO - Return code: 0 08:09:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:21 INFO - 'HOME': '/Users/cltbld', 08:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:21 INFO - 'LOGNAME': 'cltbld', 08:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:21 INFO - 'MOZ_NO_REMOTE': '1', 08:09:21 INFO - 'NO_EM_RESTART': '1', 08:09:21 INFO - 'PAGER': '/bin/cat', 08:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:21 INFO - 'PWD': '/builds/slave/test', 08:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:21 INFO - 'SHELL': '/bin/bash', 08:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:21 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:21 INFO - 'USER': 'cltbld', 08:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:21 INFO - 'XPC_FLAGS': '0x0', 08:09:21 INFO - 'XPC_SERVICE_NAME': '0', 08:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:09:24 INFO - Installing collected packages: mozsystemmonitor 08:09:24 INFO - Running setup.py install for mozsystemmonitor 08:09:24 INFO - Successfully installed mozsystemmonitor 08:09:24 INFO - Cleaning up... 08:09:24 INFO - Return code: 0 08:09:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:24 INFO - 'HOME': '/Users/cltbld', 08:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:24 INFO - 'LOGNAME': 'cltbld', 08:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:24 INFO - 'MOZ_NO_REMOTE': '1', 08:09:24 INFO - 'NO_EM_RESTART': '1', 08:09:24 INFO - 'PAGER': '/bin/cat', 08:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:24 INFO - 'PWD': '/builds/slave/test', 08:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:24 INFO - 'SHELL': '/bin/bash', 08:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:24 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:24 INFO - 'USER': 'cltbld', 08:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:24 INFO - 'XPC_FLAGS': '0x0', 08:09:24 INFO - 'XPC_SERVICE_NAME': '0', 08:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:27 INFO - warning: no files found matching '*.txt' 08:09:27 INFO - no previously-included directories found matching 'build' 08:09:27 INFO - no previously-included directories found matching 'dist' 08:09:27 INFO - no previously-included directories found matching '.git*' 08:09:27 INFO - Installing collected packages: jsonschema, functools32 08:09:27 INFO - Running setup.py install for functools32 08:09:28 INFO - warning: no files found matching '*.txt' 08:09:28 INFO - no previously-included directories found matching 'build' 08:09:28 INFO - no previously-included directories found matching 'dist' 08:09:28 INFO - no previously-included directories found matching '.git*' 08:09:28 INFO - Successfully installed jsonschema functools32 08:09:28 INFO - Cleaning up... 08:09:28 INFO - Return code: 0 08:09:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:28 INFO - 'HOME': '/Users/cltbld', 08:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:28 INFO - 'LOGNAME': 'cltbld', 08:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:28 INFO - 'MOZ_NO_REMOTE': '1', 08:09:28 INFO - 'NO_EM_RESTART': '1', 08:09:28 INFO - 'PAGER': '/bin/cat', 08:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:28 INFO - 'PWD': '/builds/slave/test', 08:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:28 INFO - 'SHELL': '/bin/bash', 08:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:28 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:28 INFO - 'USER': 'cltbld', 08:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:28 INFO - 'XPC_FLAGS': '0x0', 08:09:28 INFO - 'XPC_SERVICE_NAME': '0', 08:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:09:28 INFO - Cleaning up... 08:09:28 INFO - Return code: 0 08:09:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:28 INFO - 'HOME': '/Users/cltbld', 08:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:28 INFO - 'LOGNAME': 'cltbld', 08:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:28 INFO - 'MOZ_NO_REMOTE': '1', 08:09:28 INFO - 'NO_EM_RESTART': '1', 08:09:28 INFO - 'PAGER': '/bin/cat', 08:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:28 INFO - 'PWD': '/builds/slave/test', 08:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:28 INFO - 'SHELL': '/bin/bash', 08:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:28 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:28 INFO - 'USER': 'cltbld', 08:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:28 INFO - 'XPC_FLAGS': '0x0', 08:09:28 INFO - 'XPC_SERVICE_NAME': '0', 08:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:32 INFO - Downloading docopt-0.6.1.tar.gz 08:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:32 INFO - Running setup.py install for blobuploader 08:09:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:32 INFO - Running setup.py install for requests 08:09:33 INFO - Running setup.py install for docopt 08:09:33 INFO - Successfully installed blobuploader requests docopt 08:09:33 INFO - Cleaning up... 08:09:33 INFO - Return code: 0 08:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:33 INFO - 'HOME': '/Users/cltbld', 08:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:33 INFO - 'LOGNAME': 'cltbld', 08:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:33 INFO - 'MOZ_NO_REMOTE': '1', 08:09:33 INFO - 'NO_EM_RESTART': '1', 08:09:33 INFO - 'PAGER': '/bin/cat', 08:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:33 INFO - 'PWD': '/builds/slave/test', 08:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:33 INFO - 'SHELL': '/bin/bash', 08:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:33 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:33 INFO - 'USER': 'cltbld', 08:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:33 INFO - 'XPC_FLAGS': '0x0', 08:09:33 INFO - 'XPC_SERVICE_NAME': '0', 08:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-X1cyLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-LbDzwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-P61ryd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-TpfWRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-AnEdxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-rost2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-89hKuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-UUwH7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-wV62N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-XA2kyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-1KwcdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3slT72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-RIZWYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-kQJFMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-LB2uBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zPOn2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-hfSZm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:35 INFO - Running setup.py install for manifestparser 08:09:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:35 INFO - Running setup.py install for mozcrash 08:09:35 INFO - Running setup.py install for mozdebug 08:09:35 INFO - Running setup.py install for mozdevice 08:09:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Running setup.py install for mozfile 08:09:36 INFO - Running setup.py install for mozhttpd 08:09:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Running setup.py install for mozinfo 08:09:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Running setup.py install for mozInstall 08:09:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:36 INFO - Running setup.py install for mozleak 08:09:36 INFO - Running setup.py install for mozlog 08:09:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for moznetwork 08:09:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozprocess 08:09:37 INFO - Running setup.py install for mozprofile 08:09:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozrunner 08:09:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozscreenshot 08:09:37 INFO - Running setup.py install for moztest 08:09:37 INFO - Running setup.py install for mozversion 08:09:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:38 INFO - Cleaning up... 08:09:38 INFO - Return code: 0 08:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:38 INFO - 'HOME': '/Users/cltbld', 08:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:38 INFO - 'LOGNAME': 'cltbld', 08:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:38 INFO - 'MOZ_NO_REMOTE': '1', 08:09:38 INFO - 'NO_EM_RESTART': '1', 08:09:38 INFO - 'PAGER': '/bin/cat', 08:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:38 INFO - 'PWD': '/builds/slave/test', 08:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:38 INFO - 'SHELL': '/bin/bash', 08:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:38 INFO - 'USER': 'cltbld', 08:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:38 INFO - 'XPC_FLAGS': '0x0', 08:09:38 INFO - 'XPC_SERVICE_NAME': '0', 08:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pTzvRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-MiRU6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-HTEN3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-50LE7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-_2J6kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:38 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)) 08:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-o52wRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-8zzhpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-j5MTEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zbou4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ZbOo5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-M0dUDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-P_I_Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:39 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)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Z0avxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ckAO9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:39 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)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xIHaSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:40 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9FKgK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:40 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)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:40 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-kCpBCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:42 INFO - Downloading blessings-1.6.tar.gz 08:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:43 INFO - Installing collected packages: blessings 08:09:43 INFO - Running setup.py install for blessings 08:09:43 INFO - Successfully installed blessings 08:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:43 INFO - Reading from file tmpfile_stdout 08:09:43 INFO - Current package versions: 08:09:43 INFO - blessings == 1.6 08:09:43 INFO - blobuploader == 1.2.4 08:09:43 INFO - docopt == 0.6.1 08:09:43 INFO - functools32 == 3.2.3-2 08:09:43 INFO - jsonschema == 2.5.1 08:09:43 INFO - manifestparser == 1.1 08:09:43 INFO - mozInstall == 1.12 08:09:43 INFO - mozcrash == 1.0 08:09:43 INFO - mozdebug == 0.1 08:09:43 INFO - mozdevice == 0.49 08:09:43 INFO - mozfile == 1.2 08:09:43 INFO - mozhttpd == 0.7 08:09:43 INFO - mozinfo == 0.9 08:09:43 INFO - mozleak == 0.1 08:09:43 INFO - mozlog == 3.4 08:09:43 INFO - moznetwork == 0.27 08:09:43 INFO - mozprocess == 0.25 08:09:43 INFO - mozprofile == 0.28 08:09:43 INFO - mozrunner == 6.13 08:09:43 INFO - mozscreenshot == 0.1 08:09:43 INFO - mozsystemmonitor == 0.3 08:09:43 INFO - moztest == 0.8 08:09:43 INFO - mozversion == 1.4 08:09:43 INFO - psutil == 3.1.1 08:09:43 INFO - requests == 1.2.3 08:09:43 INFO - wsgiref == 0.1.2 08:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:43 INFO - 'HOME': '/Users/cltbld', 08:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:43 INFO - 'LOGNAME': 'cltbld', 08:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:43 INFO - 'MOZ_NO_REMOTE': '1', 08:09:43 INFO - 'NO_EM_RESTART': '1', 08:09:43 INFO - 'PAGER': '/bin/cat', 08:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:43 INFO - 'PWD': '/builds/slave/test', 08:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:43 INFO - 'SHELL': '/bin/bash', 08:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:43 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:43 INFO - 'USER': 'cltbld', 08:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:43 INFO - 'XPC_FLAGS': '0x0', 08:09:43 INFO - 'XPC_SERVICE_NAME': '0', 08:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e25cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb293dad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, '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.6V8sE6UIm8/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.hm3UjrukdN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 08:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:43 INFO - 'HOME': '/Users/cltbld', 08:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:43 INFO - 'LOGNAME': 'cltbld', 08:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:43 INFO - 'MOZ_NO_REMOTE': '1', 08:09:43 INFO - 'NO_EM_RESTART': '1', 08:09:43 INFO - 'PAGER': '/bin/cat', 08:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:43 INFO - 'PWD': '/builds/slave/test', 08:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:43 INFO - 'SHELL': '/bin/bash', 08:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:09:43 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:43 INFO - 'USER': 'cltbld', 08:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:43 INFO - 'XPC_FLAGS': '0x0', 08:09:43 INFO - 'XPC_SERVICE_NAME': '0', 08:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:44 INFO - Cleaning up... 08:09:44 INFO - Return code: 0 08:09:44 INFO - Running post-action listener: _resource_record_post_action 08:09:44 INFO - Running post-action listener: _start_resource_monitoring 08:09:44 INFO - Starting resource monitoring. 08:09:44 INFO - [mozharness: 2017-03-12 15:09:44.100527Z] Finished create-virtualenv step (success) 08:09:44 INFO - [mozharness: 2017-03-12 15:09:44.101532Z] Running install step. 08:09:44 INFO - Running pre-action listener: _resource_record_pre_action 08:09:44 INFO - Running main action method: install 08:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:44 INFO - Reading from file tmpfile_stdout 08:09:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:44 INFO - Reading from file tmpfile_stdout 08:09:44 INFO - Output received: 08:09:44 INFO - Usage: mozinstall [options] installer 08:09:44 INFO - Options: 08:09:44 INFO - -h, --help show this help message and exit 08:09:44 INFO - -d DEST, --destination=DEST 08:09:44 INFO - Directory to install application into. [default: 08:09:44 INFO - "/builds/slave/test"] 08:09:44 INFO - --app=APP Application being installed. [default: firefox] 08:09:44 INFO - mkdir: /builds/slave/test/build/application 08:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:10:04 INFO - Reading from file tmpfile_stdout 08:10:04 INFO - Output received: 08:10:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:10:04 INFO - Running post-action listener: _resource_record_post_action 08:10:04 INFO - [mozharness: 2017-03-12 15:10:04.507878Z] Finished install step (success) 08:10:04 INFO - [mozharness: 2017-03-12 15:10:04.508028Z] Running run-tests step. 08:10:04 INFO - Running pre-action listener: _resource_record_pre_action 08:10:04 INFO - Running main action method: run_tests 08:10:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:10:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:10:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:10:04 INFO - 2017-03-12 08:10:04.522 screenresolution[1741:17287] starting screenresolution argv=screenresolution get 08:10:04 INFO - 2017-03-12 08:10:04.525 screenresolution[1741:17287] Display 0: 1600x1200x32@60 08:10:04 INFO - 2017-03-12 08:10:04.531 screenresolution[1742:17290] starting screenresolution argv=screenresolution list 08:10:04 INFO - Available Modes on Display 0 08:10:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:10:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:10:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:10:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:10:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:10:04 INFO - Intel Iris: 08:10:04 INFO - Chipset Model: Intel Iris 08:10:04 INFO - Type: GPU 08:10:04 INFO - Bus: Built-In 08:10:04 INFO - VRAM (Dynamic, Max): 1536 MB 08:10:04 INFO - Vendor: Intel (0x8086) 08:10:04 INFO - Device ID: 0x0a2e 08:10:04 INFO - Revision ID: 0x0009 08:10:04 INFO - Displays: 08:10:04 INFO - Display: 08:10:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:10:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:10:04 INFO - Display Serial Number: 1600x1200 60 08:10:04 INFO - Main Display: Yes 08:10:04 INFO - Mirror: Off 08:10:04 INFO - Online: Yes 08:10:04 INFO - Rotation: Supported 08:10:04 INFO - Return code: 0 08:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:04 INFO - Python 2.7.3 08:10:04 INFO - Return code: 0 08:10:04 INFO - grabbing minidump binary from tooltool 08:10: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')]} 08:10:04 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 0x10e03ad30>, '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 0x10df61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e02fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:04 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 08:10:04 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 08:10:04 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 08:10:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:04 INFO - Return code: 0 08:10:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:10:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:04 INFO - ENV: RUST_BACKTRACE is now 1 08:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6V8sE6UIm8/Render', 08:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:04 INFO - 'HOME': '/Users/cltbld', 08:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:04 INFO - 'LOGNAME': 'cltbld', 08:10:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:04 INFO - 'MOZ_NO_REMOTE': '1', 08:10:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:04 INFO - 'NO_EM_RESTART': '1', 08:10:04 INFO - 'PAGER': '/bin/cat', 08:10:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:04 INFO - 'PWD': '/builds/slave/test', 08:10:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:04 INFO - 'RUST_BACKTRACE': '1', 08:10:04 INFO - 'SHELL': '/bin/bash', 08:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hm3UjrukdN/Listeners', 08:10:04 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 08:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:04 INFO - 'USER': 'cltbld', 08:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:04 INFO - 'XPC_FLAGS': '0x0', 08:10:04 INFO - 'XPC_SERVICE_NAME': '0', 08:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:10:05 INFO - mozversion application_buildid: 20170312072936 08:10:05 INFO - mozversion application_changeset: d173b2b2852fde503b1e42875982ad023ab3ad8b 08:10:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:10:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:05 INFO - mozversion application_name: Firefox 08:10:05 INFO - mozversion application_remotingname: firefox-dev 08:10:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:10:05 INFO - mozversion application_vendor: Mozilla 08:10:05 INFO - mozversion application_version: 54.0a2 08:10:05 INFO - mozversion platform_buildid: 20170312072936 08:10:05 INFO - mozversion platform_changeset: d173b2b2852fde503b1e42875982ad023ab3ad8b 08:10:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:10:05 INFO - mozversion platform_version: 54.0a2 08:10:05 INFO - using testdate: 1489331405 08:10:05 INFO - actual date: 1489331405 08:10:05 INFO - starting webserver on 'localhost:49244' 08:10:05 INFO - SUITE-START | Running 2 tests 08:10:05 INFO - TEST-START | dromaeo_css 08:10:05 INFO - operating with platform_type : mac_ 08:10:05 INFO - Initialising browser for dromaeo_css test... 08:10:05 INFO - TEST-INFO | started process 1752 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpVxb5DL/profile http://localhost:49244/getInfo.html) 08:10:08 INFO - PROCESS | 1752 | 2017-03-12 08:10:08.187 plugin-container[1755:17485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 08:10:08 INFO - PROCESS | 1752 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:10:08 INFO - PROCESS | 1752 | 2017-03-12 08:10:08.190 plugin-container[1755:17485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9617, name = 'com.apple.CFPasteboardClient' 08:10:08 INFO - PROCESS | 1752 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:10:08 INFO - PROCESS | 1752 | 2017-03-12 08:10:08.190 plugin-container[1755:17485] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:10:08 INFO - PROCESS | 1752 | __metrics Screen width/height:1600/1200 08:10:08 INFO - PROCESS | 1752 | colorDepth:24 08:10:08 INFO - PROCESS | 1752 | Browser inner width/height: 1024/689 08:10:08 INFO - PROCESS | 1752 | __metrics 08:10:08 ERROR - PROCESS | 1752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:10:09 INFO - TEST-INFO | 1752: exit 0 08:10:09 INFO - Browser initialized. 08:10:09 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:09 INFO - TEST-INFO | started process 1756 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpVxb5DL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:11 INFO - PROCESS | 1756 | 2017-03-12 08:10:11.564 plugin-container[1757:17615] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 08:10:11 INFO - PROCESS | 1756 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:10:11 INFO - PROCESS | 1756 | 2017-03-12 08:10:11.564 plugin-container[1757:17615] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 08:10:11 INFO - PROCESS | 1756 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:10:11 INFO - PROCESS | 1756 | 2017-03-12 08:10:11.564 plugin-container[1757:17615] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:10:21 INFO - PROCESS | 1756 | RSS: Main: 221196288 08:10:21 INFO - PROCESS | 1756 | 08:13:26 INFO - PROCESS | 1756 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 08:13:27 INFO - PROCESS | 1756 | RSS: Main: 238956544 08:13:27 INFO - PROCESS | 1756 | 08:15:09 INFO - PROCESS | 1756 | ************************* 08:15:09 INFO - PROCESS | 1756 | A coding exception was thrown and uncaught in a Task. 08:15:09 INFO - PROCESS | 1756 | 08:15:09 ERROR - PROCESS | 1756 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:15:09 INFO - PROCESS | 1756 | Full stack: 08:15:09 INFO - PROCESS | 1756 | ************************* 08:16:29 INFO - PROCESS | 1756 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 08:16:30 INFO - PROCESS | 1756 | RSS: Main: 248557568 08:16:30 INFO - PROCESS | 1756 | 08:19:32 INFO - PROCESS | 1756 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 08:19:33 INFO - PROCESS | 1756 | RSS: Main: 255221760 08:19:33 INFO - PROCESS | 1756 | 08:22:34 INFO - PROCESS | 1756 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 08:22:35 INFO - PROCESS | 1756 | RSS: Main: 252321792 08:22:35 INFO - PROCESS | 1756 | 08:25:38 INFO - PROCESS | 1756 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 08:25:39 INFO - PROCESS | 1756 | RSS: Main: 257331200 08:25:39 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 08:28:42 INFO - PROCESS | 1756 | RSS: Main: 253616128 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | __start_tp_report 08:28:42 INFO - PROCESS | 1756 | _x_x_mozilla_page_load 08:28:42 INFO - PROCESS | 1756 | _x_x_mozilla_page_load_details 08:28:42 INFO - PROCESS | 1756 | |i|pagename|runs| 08:28:42 INFO - PROCESS | 1756 | |0;dojo.html;2942.9852850735742;3515.964840351597;3516.7538272320935;3542.9114272143192;3551.9112022199442;6127.448529632332;6151.938480615193;6185.412385823345;6205.813825585228;6211.50307975362;6148.600340977833;6148.877022459548;6182.041783523561;6233.1273621693;6233.657148856811;5508.99999999999;5538.972305138469;5597.104463285875;5664.376918538957;5693.686847223401;5689.943100568983;5697.202391665171;5706.429357064281;5719.19931209631;5745.540356771469;5468.7539060742165;5469.535089517396;5528.944710552883;5667.546596272288;5676.347220069683;5544.528715059225;5622.100463925753;5622.550195984332;5683.318001839764;5717.885642287131;5451.3458384994055;5598.916016259759;5600.4959553640365;5605.1872478490795;5612.971935140339;6205.81382558524;6224.87550248997;6277.2153480814895;6288.496920246369;6306;6249.2813326467585;6303.432691057827;6310.116583678288;6403.0715546246;6433.195850518685;6609.107770450975;6634.601923884534;6643.60138391698;6663.433608143314;6670.466362690973;5236.6857988520815;6227;6283.874322513524;6285.277193122758;6299.307076221612;6435.581687190318;6511.218653761579;6556.803295901131;6767.458603311723;6810.387065164159;5529.391766905637;6344.1118243445035;6386.8722625547225;6405.135306733531;6419.390157934989;6491.383318584727;6614.04096406028;6635.535512514078;6637.435817955527;6637.86724265512;6256.593321434092;6305;6369.9681501592195;6532.8366790830605;6537.477001839841;6299.96850015747;6378.075179099004;6420.775272865428;6458.321876202931;6549.705263263165;5204.895902082013;5217.6347655664495;5261.5264626183825;5295.920561191509;5311.442298558596;4665.836695715701;4690.343351930733;4716.834910778106;4721.504242054535;4808.182608956486;6035.064564992434;6104.603200791934;6200.968995155085;6207.255129384503;6245.500359971192;6447.6131432114225;6471.7734879279;6525.738970441129;6531.412172904462;6569.113169722026;5077.8730531737;6229.283632382243;6241.313455519889;6247.625142491465;6288.056791481315;5817.243758311392;5827.35899051104;5837.591368604157;5854.18041474194;5855.677937713382;6535.869282614416;6547.410733034049;6709.329067093252;6748.223954245324;7022.43820494349;6550.377714117151;6649.867002660017;6671.566348187353;6672.132622759011;6686.364795344434;6793.6942837573415;6824.590524568542;6832.453403727591;6838.076859624086;6847.965760171366;6288.465480434214;6363.140975968185;6418.133551970424;6424.261209960914;6530.412262896362;6660.900086498609;6675.899861502178;6680.465562754871;6691.2639609643875;6700.329967003456;6439.710213040331;6452.387023232785;6491.902621460587;6498.935010650022;6507.089007539043;6256.624602523863;6266.655333956676;6295.811125666238;6388.233411990591;6481.4166724994975;6128.319797384666;6313.873722525615;6318.115463835159;6330.841728956813;6348.016057511093;6409.9359006411205;6438.935610643834;6454.934935735551;6459.806205813833;6464.41820236181;6135.171422439309;6230.252369715663;6232.968835155795;6235.220597425322;6246.250449946036 08:28:42 INFO - PROCESS | 1756 | |1;ext.html;717.8026042838219;800.8278220182659;819.4264015189369;955.3742298794292;963.7686955130762;38187.61812381876;38853.61146388539;40148.59851401492;40178.995525111815;40213.79358619243;38884.80557597208;38990.80504597473;39108.41337379935;39128.60871391292;39158.608413915856;7936.365090792751;8068.475549089319;10581.312214706059;10900.50947707355;11031.282966607145;10747.355158690465;10830.350178989247;10831.891681083207;10845.240833141683;10847.566097356097;10814.675559733221;10839;10853.023227909487;10854.185936054788;10857.67426977188;10783.676489705282;10792.082672972807;10794.190435717313;10812.080973117216;10856.620018299362;10545.525451354632;10553.84169237462;10561.207909406825;10587.153027757839;10597.576096956112;33550.664493355;33717;33768.98693039188;33820.323593528236;33890;2949.0710426215674;3763.4354846773203;3769.7738135711943;3776.131489757344;3833.7318484278126;24920.626190607156;25085.49829003428;25388.11141610053;26377.472450551075;26415.075472358374;3064.0960916529675;3135.9059228222964;3153.716165545089;3173.428782819092;3272.5582046423665;357895;367861;368487.1575642105;368962;369576;42460.7261782147;42585.57414425878;42610.57389426128;42742;42751;36026.63973360285;43344.78327608405;44019;44124.338134928;44293;12547.749045019049;12616.747665046647;12665.303408312631;12670.80993785094;12696.365181741061;10745.194110441747;10893.782124357469;10894.237403381687;10920.071793897449;10951.247800351906;11415.543378264943;11427.200095993201;11447.427628618703;11464.713382165346;11493;5706.4864162225595;5736.110902810071;5811.912821307684;5840.065589505659;5843.298804143445;849.796048948248;933.5612262236738;951.286535098676;965.3194497878978;990.0000998990927;28047.439051218862;28050.43899122006;28130.859345703142;28327.57508637372;28562.85718571394;1030.6341248856697;1041.193075366597;1066.8666416697913;1075.4945175767534;1079.5681727309138;12653.683657908627;12769.489220431264;14161.362738676784;14909.956303058898;15622.9218853905;387224;387876;388552;389237;393034;51275.23087153696;51614.48385516172;51658;51850.48149518532;51977.96044079173;1410.5133728863525;1453.4476898778396;1461.7368873602854;1463.0563286680244;1463.144060724488;26169;26640;27461.45077098487;27501.449971000868;27753.306167345978;43388.566114339716;43416.78291608522;43428;43432.565674344114;43510.34734479048;359046;360802;360882;361417;362749;28600.570991434728;29388.7061129386;30521.389572208875;30621.23446913845;30659;37704.43443348407;37776.81111594424;38319.04202394962;38570.80714596409;38658;32061.83969080233;32317;32328.83835580807;33116;33323.500147497325;21208.469788255417;26273.868630656725;26905.461890762468;31825.5226171603;33526.497102543966;26939.865300673373;27281.863590681918;31587.684123158473;32120;32261.87083452068;26969.325766855985;28978.7102128976;29312.56031159577;29415.705842941297;29499.96750113736;22494;22525.662115068615;22699.319020429415;22756.886215568815;22788.43028924224 08:28:42 INFO - PROCESS | 1756 | |2;jquery.html;376.170543950589;409.11834995584525;411.17559293616296;424.21096760026353;452.7328875963181;18070.367537136204;19846.7022994655;20233.696494552576;20935.162593496243;21469.67795483069;21473.248436304693;21498.247561335356;21910.780892191113;22451.77548224517;22618.321450356514;6052.122442245872;6318.715657795387;6702.731890724365;6885.621290829003;6890.793276201722;6463.450606698436;6606.174228221473;6709.8322541936595;6750.021246919194;6790;6435.613863168225;6685.598864068147;6719.6640167991645;6774.898376524356;6776.2546119926765;6560.2455717592375;6700.162479690039;6702.36327548882;6722.865542689167;6729.7308107675635;6237.968810155966;6447.129637498924;6557.3442655734525;6592.86814263712;6612.702428390686;26341.07806226792;26592.335191620172;26665.600015999775;26788;26983.86508067447;2856.157433557106;2875.295552589608;2994.3562134141266;3024.228821650487;3073.400686866062;15922.920385398114;16812.159392030473;16837.579060523585;17067.061311627855;17420.47738567845;2044.2742826296599;2070.565181311926;2071.9378418647316;2072.347210628647;2075.335892514396;134277;136120;137783;137924.31037844747;139536;22693;22793.544129117327;23076.076956921872;23312.88343558305;23353;35306.82346588251;35363.115922101635;35703.64296357055;36095.91712248637;36096.639033609856;9127.863082053775;9201.447913125234;9352.532373381304;9355.391899526508;9439.386439881386;6143.508519318444;7362.3373896349585;7417.221191774894;7455.403567714569;7544.547327160388;8692.913070869337;10525.579046828734;10585.57657693699;10628.521716522775;10721.571137154582;3543.5924868639922;4007.8196481158416;4229.238737027303;4397.802098905557;4546.909061818811;938.1884669760608;947.7867479817124;954.494118117385;966.8018056298442;983.7638966647953;22129.557408852055;23199.884000580227;23316.883415583154;23389;23451.765482345298;966.9371490853072;967.8354679704468;995.8954309797512;1003.8644782954208;1007.2898606482412;8902.821943561223;11517.82723259135;12015.219010764273;12212.32832194238;12482.875171248172;686214;738585;792631;795436;812806;170361.14819425825;170538;173129;173598;174357;1071.6302875507938;1238.8885000350012;1288.5296866643796;1295.3264302562616;1296.935153242334;19491.610167796847;19752.30866919651;20108.99455027272;20187.697184542536;20192.88939108363;63083;66960.99558506529;67304;67456.6627166861;68435.65782171057;80762;95575.04424955661;96256;98138.509307453;99069;9091.363604547618;11443.48504317291;11862.56817352458;11899.107566932342;11970.401479925795;10819.891801081889;12881.613551593467;12954.870451295366;13183.40674669623;13191.934040329737;11071.003609674846;11275.830862537232;11406.372649504357;11476.368799716096;11565.248258863146;11127.499262533367;11315.886841131483;11387.658370248906;11431.771364572496;11733.413329333329;11493.942530287295;11787.351695656822;11881.762364752829;11884.227525210834;11930.880691192977;11561.710957226136;11916.761664766484;11957.820632690691;11968.820467692818;11990.580329688419;11391.829122563335;11521.711957201138;11700.824487632523;11749.706257343634;11792.938635522843 08:28:42 INFO - PROCESS | 1756 | |3;mootools.html;1433.4552869909433;1535.240056172195;1536.5390382885146;1561.7193901001176;1581.3358389476418;10715.571377144915;11193.944030279858;11296.265742726717;11308.830367544493;11554.364509951949;11278.492467838947;11436.313821170716;11447.713807154825;11456.541738330458;11502.964733174013;2393.688820453339;2419.129113519132;2433.5497932882386;2433.634954756792;2435.7320694723567;2357.764223577637;2396.1373905394044;2397.4006498375406;2400.2799160251943;2402.939926501834;2404.651325557793;2419.6491508731224;2424.3211900667843;2428.9149879754214;2443.9022439102414;2381.6784734060852;2388.7969522590515;2403.42317843718;2406.2059520358325;2407.4462873539183;2353.717553893544;2355.0815182079004;2373.0389192377115;2411.1560953666253;2412.1798588479824;11263.943680281629;11312.151588630803;11313;11317.603883864107;11330.546778128864;5749.741261643236;5886;5957.285125784891;5964.075568286922;5971.641701497924;3116.0496048705136;3450.5341778859784;3538.327717733622;3567.019069755838;3587.121155316938;1161.7211869151427;1166.9533218671243;1173.7652469506133;1217.5008246618843;1242.6085782978332;13923.791143132963;14079.648008799759;14263.643408914757;15602.29789659468;15784.289706963214;4527.456705195397;4617.145828021827;4748.738819364969;4776;4781.450133234723;11632;11693.766124677459;11697.064234861191;11698.06415486776;11726.472308746126;5730.570207234474;5783.248177736868;5790.942090579125;5792.913106303409;5800.9129863052085;4086.959130408717;5225.895482090337;5245.10833158364;5280.709560974184;5292.417834038252;2972.658144313388;3401.013706025225;3731.421629647409;3738.2710371477847;3980.4228386883738;999.7500624843789;1026.697124348319;1028.1620479309338;1041.2763129624989;1048.1248157788332;929.6560272699145;944.17856464876;945.6264775413673;952.1953948913157;1004.5128112865254;6537.705803238866;6605.57063790852;6609.6364699941005;6819.522633415613;6822.044913712084;921.0513171433435;966.3525437956446;1005.2058873489862;1020.1889497849079;1068.1348108032519;4272.9359059614135;4274.380214868826;4284.2930916398445;4330.631896288788;4398.47218333802;12767.553135640208;13098.803517947239;13119.95040396766;13147.802782958262;13163.53927612529;12981.805272920914;13203;13676.93161534186;13870.722585548434;13945.860541394457;8686.695965641173;8793.428427152214;9404.95297523508;9541.47521886303;10327.173826093895;6030.849228769316;6743.79768606923;6860.6912688930115;6891.345322194384;6923.515353925177;11906.523739050688;11987.400629968291;12207.45066471993;12229.3273869938;12232.388380581113;10611.575536978744;12396.31820249895;12626;12807.743845123232;12969.35153242353;7103.680334385069;9422.764430889283;9512.95243523778;9524.666636667684;9541.473364261685;10319.432431216355;10477.790444191225;10484.580616775243;10487.842682359618;10498.475076246004;9083.545822708971;9305.581248843682;9332.81334373295;9365.391249568756;9400.717978460658;6972.616506092214;8896;9071.546422678972;9174.816503670023;9209.401388909699;7920.485168464032;7944.364450843803;8059.758207253792;8065.717699880476;8144.104148543774;5794.275715535558;5812.099124635688;5880.970595146997;5943.078822782476;5984.102384642339;5840.123981402823;5927.85180370477;6126.846828829315;6145.754169833157;6257 08:28:42 INFO - PROCESS | 1756 | |4;prototype.html;353.34983630120576;361.38023290057555;372.45249483259613;377.6865201882438;393.1037235103963;4761.690490118149;5074.314967479389;5328.53465297043;5358.892822143554;5436.456354364562;4197.79011049447;4544.3183522471645;5077.796888124471;5366.812161574346;5372.54333381663;4037.596240375968;4048.716589838698;4301.946023224315;4308.569143085698;4409.8754817521485;3420.572428446444;3692.1138926657545;3948.644621984021;4376.584224498668;4415.646748260131;3957.76253424794;4466.754328511931;4480.611010586712;4506.805696490433;4523.638108951292;3321.4519604265265;3666.0203490115305;4099.528554216244;4240.473429565354;4475.932861007088;3903.7703123516003;3993.1614360984227;4043.8584649537124;4077.7970498702953;4107.876763697094;5137.921036582322;5200.323957885488;5220.6084543659;5238.659487133325;5243.659162154448;4217.768022758747;4346.500152482474;4660.39414876064;4767.570918617341;4816.831410900601;4930.704157750511;5424.267723857308;5744.798932037401;5770.336411312711;5852.795152169653;4609.677322587387;4633.2818413146015;4636.09596128755;4640.651951103647;4645.488996210414;4945.258211268302;5440.211169380417;5699.960548722366;5791.478766910998;6121.632702037892;4686.437627484724;5221.895562088737;5235.607329450307;5245.816396426107;5256.763445644955;4815.855524334275;5296.629235953524;5346.0281937797445;5389.838304850782;5419.674819510842;4403.515613282536;5335.813246536352;5356.812511562077;5468.343798744176;5553.250311207935;5402.812340718995;5633.873225354945;5642.548596112383;5659.603827732019;5667.716614169275;1492.641765976158;1575.6769862178226;1709.8204688507528;1743.378657848188;1743.7907451105948;1251.718363368253;1326.820879181298;1350.6291114518772;1383.9100458470168;1469.6472846516758;4929.654924155275;5159.922601160985;5315.7042633567435;5351.464853514617;5394.433584473652;5273.841784746463;5496.890062198733;5623;5691.373948865621;5911.674857882772;4752.7385993769985;5018.971110922253;5065.6200784941275;5352;5403.675779453167;3091.5053591425262;3100.093442532826;3100.8294543800307;3102.602650098139;3105.5714371388963;5193.532582067632;5407.729613519308;5838.2702162229725;6164;6227.439530442282;5453.672779633234;5920.970395147997;6004.369541198112;6058.848528786727;6059.818725079681;4839.467658557556;5532.502074813206;6056.121862330026;6075.301340345828;6214.875702485834;5653.378128405954;5938.435848594377;5938.910916336345;6044.788432405021;6049.455549000611;4954.266006897557;4992.5756310714;5751.079827227623;5966.8961242170335;5990.981533139289;5558.861028474321;5717.5425965921795;5751.562109472632;5782.624129431573;5982.521398288213;4109.671226301948;4669;5000.174971129868;5179.48205179479;5202.959408118467;5025.623078269217;5365.141577347606;5546;5557.527610153021;5974.116824064393;5680.630759000652;5697.607005057968;5735.426457354231;5769.68266745333;5788.305403351625;4978;5044.520770526794;5493.862653433536;5783.768649253982;5803.7678492861505;5275;5551.500364967173;5660.462256085665;5695.952665324032;5715.628484148517;4988.401391832858;5468.418186088119;5833.183354330312;5850.338096166319;5859.384764599826;5363.356397232357;5470.452954704498;5583.804566840141;5629.915551266816;5714.885702286014 08:28:42 INFO - PROCESS | 1756 | |5;yui.html;640.3820313397571;709.711872950595;765.0971853213209;791.7624712586223;846.3736834742291;13162.736745265089;15469.303881325339;16161.595960100989;16180.83819161808;17080.658386832256;15330.923345383286;15725;15858.841411585881;15930.522084337488;15935.44225952092;911.0661571888801;933.8039011807529;934.8644446555245;937.3063932689795;942.9339946203769;908.1917093786535;941.0448394879203;943.0428115462811;946.1106559833769;946.7585765629755;994.22450488619;996.2229461020415;996.7707427291728;999.605155963394;1000.6447711062577;980.6910823090703;986.7434467038549;987.1757082835804;989.1493315748487;990.0050449298409;726.4079774983371;734.6951015328632;735.0040694858496;735.1912895814561;736.5948728199469;15854.841451585567;16167.353305867751;16458.42395516151;17035.574110647332;17330.220140093727;13948.442062317496;14135.363908624136;14255.643608909757;14355.928220358936;14464.49374271906;9708.271879609058;11719.414029298501;11798.88201117995;11904.226225295328;12423.44094515749;3078.5064098080625;3152.6059242594674;3614.4036234021355;3847.442120892455;3850.095227621535;74675;76513.61743191304;78600.21399786044;94916;111220.4438977808;9044.959829619678;10562.788744225072;10993.230473866752;11204.719882003015;11498.25261358009;21960.34118976433;22032.11871525153;22376;22502.887485562467;22511.549769004527;7787.260210280015;7866.7639970800965;7868.567228802356;7935.166807485246;8142.633581488847;3870.283997460479;4277.251480990876;4350.260455722471;4382.846600368972;4391.6486681065435;2710.3901622134863;3213.068210219057;3466.9826650866585;3512.24486735348;3554.3779838528153;642.0818229931243;644.0982624325981;651.4885814635583;657.3196741372752;658.7957733102753;663.1809715001968;668.4151367553391;689.1661090080958;700.3206889317354;723.2875617516742;9668.371555848847;9936.238573176312;10013.39568051558;10079.799237220479;10539.683809485728;574.6351067072355;673.8342667185698;680.9625470599066;681.1553673444992;687.9449644028466;4685.691002777604;5103.157978933508;5112.8721781955;5113.795448182031;5288.365396152486;90623.54688226516;90751;110072.4496377513;112432.56743256743;115294;87914;89046;95857.52071239598;99972;100261;74560.88158677732;85292.57353713192;88662.55668721744;91874.54062729643;92547.07452925519;9469.715908522756;10761.46192690378;11348.546058157912;11469.655910322703;11598.420078995847;54705;55461.72269138628;55633.44366556282;56073.15890261731;57232.42767572438;55291;71587;72467.82596522113;73348.26651733414;73821;10640.414777187329;13849.307534623431;14046.929765351108;14288.714225715636;14359.569212923629;14934.497380394507;15091.320890559731;15305.6173595661;16027.198640068184;16139.75790363169;12224.92670519305;13747.037707360389;14363.712725745636;14565.490207842675;14573.562793116223;13799.586012419644;13890.652733681334;14302.71394572082;14517.927410362881;14894.702105958037;11196.328220306808;13856.376463058985;14173.22047287409;14368.497102601359;14671.926640367157;10840.837387439036;11058.723531911766;11382.94308528452;11620.6513804586;11883.227590206954;9368.625254989724;9613.615455381707;11361.943190284326;11664.591739289084;11671.824922625998 08:28:42 INFO - PROCESS | 1756 | __end_tp_report 08:28:42 INFO - PROCESS | 1756 | __start_cc_report 08:28:42 INFO - PROCESS | 1756 | _x_x_mozilla_cycle_collect,409 08:28:42 INFO - PROCESS | 1756 | __end_cc_report 08:28:42 INFO - PROCESS | 1756 | __startTimestamp1489332522834__endTimestamp 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | ------- Summary: start ------- 08:28:42 INFO - PROCESS | 1756 | Number of tests: 6 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | [#0] dojo.html Cycles:165 Average:6090.16 Median:6288.06 stddev:678.13 (10.8%) stddev-sans-first:633.68 08:28:42 INFO - PROCESS | 1756 | Values: 2943.0 3516.0 3516.8 3542.9 3551.9 6127.4 6151.9 6185.4 6205.8 6211.5 6148.6 6148.9 6182.0 6233.1 6233.7 5509.0 5539.0 5597.1 5664.4 5693.7 5689.9 5697.2 5706.4 5719.2 5745.5 5468.8 5469.5 5528.9 5667.5 5676.3 5544.5 5622.1 5622.6 5683.3 5717.9 5451.3 5598.9 5600.5 5605.2 5613.0 6205.8 6224.9 6277.2 6288.5 6306.0 6249.3 6303.4 6310.1 6403.1 6433.2 6609.1 6634.6 6643.6 6663.4 6670.5 5236.7 6227.0 6283.9 6285.3 6299.3 6435.6 6511.2 6556.8 6767.5 6810.4 5529.4 6344.1 6386.9 6405.1 6419.4 6491.4 6614.0 6635.5 6637.4 6637.9 6256.6 6305.0 6370.0 6532.8 6537.5 6300.0 6378.1 6420.8 6458.3 6549.7 5204.9 5217.6 5261.5 5295.9 5311.4 4665.8 4690.3 4716.8 4721.5 4808.2 6035.1 6104.6 6201.0 6207.3 6245.5 6447.6 6471.8 6525.7 6531.4 6569.1 5077.9 6229.3 6241.3 6247.6 6288.1 5817.2 5827.4 5837.6 5854.2 5855.7 6535.9 6547.4 6709.3 6748.2 7022.4 6550.4 6649.9 6671.6 6672.1 6686.4 6793.7 6824.6 6832.5 6838.1 6848.0 6288.5 6363.1 6418.1 6424.3 6530.4 6660.9 6675.9 6680.5 6691.3 6700.3 6439.7 6452.4 6491.9 6498.9 6507.1 6256.6 6266.7 6295.8 6388.2 6481.4 6128.3 6313.9 6318.1 6330.8 6348.0 6409.9 6438.9 6454.9 6459.8 6464.4 6135.2 6230.3 6233.0 6235.2 6246.3 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | [#1] ext.html Cycles:180 Average:50527.18 Median:3144.81 stddev:98387.93 (3128.6%) stddev-sans-first:98592.85 08:28:42 INFO - PROCESS | 1756 | Values: 717.8 800.8 819.4 955.4 963.8 38187.6 38853.6 40148.6 40179.0 40213.8 38884.8 38990.8 39108.4 39128.6 39158.6 7936.4 8068.5 10581.3 10900.5 11031.3 10747.4 10830.4 10831.9 10845.2 10847.6 10814.7 10839.0 10853.0 10854.2 10857.7 10783.7 10792.1 10794.2 10812.1 10856.6 10545.5 10553.8 10561.2 10587.2 10597.6 33550.7 33717.0 33769.0 33820.3 33890.0 2949.1 3763.4 3769.8 3776.1 3833.7 24920.6 25085.5 25388.1 26377.5 26415.1 3064.1 3135.9 3153.7 3173.4 3272.6 357895.0 367861.0 368487.2 368962.0 369576.0 42460.7 42585.6 42610.6 42742.0 42751.0 36026.6 43344.8 44019.0 44124.3 44293.0 12547.7 12616.7 12665.3 12670.8 12696.4 10745.2 10893.8 10894.2 10920.1 10951.2 11415.5 11427.2 11447.4 11464.7 11493.0 5706.5 5736.1 5811.9 5840.1 5843.3 849.8 933.6 951.3 965.3 990.0 28047.4 28050.4 28130.9 28327.6 28562.9 1030.6 1041.2 1066.9 1075.5 1079.6 12653.7 12769.5 14161.4 14910.0 15622.9 387224.0 387876.0 388552.0 389237.0 393034.0 51275.2 51614.5 51658.0 51850.5 51978.0 1410.5 1453.4 1461.7 1463.1 1463.1 26169.0 26640.0 27461.5 27501.4 27753.3 43388.6 43416.8 43428.0 43432.6 43510.3 359046.0 360802.0 360882.0 361417.0 362749.0 28600.6 29388.7 30521.4 30621.2 30659.0 37704.4 37776.8 38319.0 38570.8 38658.0 32061.8 32317.0 32328.8 33116.0 33323.5 21208.5 26273.9 26905.5 31825.5 33526.5 26939.9 27281.9 31587.7 32120.0 32261.9 26969.3 28978.7 29312.6 29415.7 29500.0 22494.0 22525.7 22699.3 22756.9 22788.4 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | [#2] jquery.html Cycles:180 Average:44127.23 Median:23334.94 stddev:127893.36 (548.1%) stddev-sans-first:128209.94 08:28:42 INFO - PROCESS | 1756 | Values: 376.2 409.1 411.2 424.2 452.7 18070.4 19846.7 20233.7 20935.2 21469.7 21473.2 21498.2 21910.8 22451.8 22618.3 6052.1 6318.7 6702.7 6885.6 6890.8 6463.5 6606.2 6709.8 6750.0 6790.0 6435.6 6685.6 6719.7 6774.9 6776.3 6560.2 6700.2 6702.4 6722.9 6729.7 6238.0 6447.1 6557.3 6592.9 6612.7 26341.1 26592.3 26665.6 26788.0 26983.9 2856.2 2875.3 2994.4 3024.2 3073.4 15922.9 16812.2 16837.6 17067.1 17420.5 2044.3 2070.6 2071.9 2072.3 2075.3 134277.0 136120.0 137783.0 137924.3 139536.0 22693.0 22793.5 23076.1 23312.9 23353.0 35306.8 35363.1 35703.6 36095.9 36096.6 9127.9 9201.4 9352.5 9355.4 9439.4 6143.5 7362.3 7417.2 7455.4 7544.5 8692.9 10525.6 10585.6 10628.5 10721.6 3543.6 4007.8 4229.2 4397.8 4546.9 938.2 947.8 954.5 966.8 983.8 22129.6 23199.9 23316.9 23389.0 23451.8 966.9 967.8 995.9 1003.9 1007.3 8902.8 11517.8 12015.2 12212.3 12482.9 686214.0 738585.0 792631.0 795436.0 812806.0 170361.1 170538.0 173129.0 173598.0 174357.0 1071.6 1238.9 1288.5 1295.3 1296.9 19491.6 19752.3 20109.0 20187.7 20192.9 63083.0 66961.0 67304.0 67456.7 68435.7 80762.0 95575.0 96256.0 98138.5 99069.0 9091.4 11443.5 11862.6 11899.1 11970.4 10819.9 12881.6 12954.9 13183.4 13191.9 11071.0 11275.8 11406.4 11476.4 11565.2 11127.5 11315.9 11387.7 11431.8 11733.4 11493.9 11787.4 11881.8 11884.2 11930.9 11561.7 11916.8 11957.8 11968.8 11990.6 11391.8 11521.7 11700.8 11749.7 11792.9 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | [#3] mootools.html Cycles:180 Average:6720.33 Median:2433.59 stddev:4183.49 (171.9%) stddev-sans-first:4176.36 08:28:42 INFO - PROCESS | 1756 | Values: 1433.5 1535.2 1536.5 1561.7 1581.3 10715.6 11193.9 11296.3 11308.8 11554.4 11278.5 11436.3 11447.7 11456.5 11503.0 2393.7 2419.1 2433.5 2433.6 2435.7 2357.8 2396.1 2397.4 2400.3 2402.9 2404.7 2419.6 2424.3 2428.9 2443.9 2381.7 2388.8 2403.4 2406.2 2407.4 2353.7 2355.1 2373.0 2411.2 2412.2 11263.9 11312.2 11313.0 11317.6 11330.5 5749.7 5886.0 5957.3 5964.1 5971.6 3116.0 3450.5 3538.3 3567.0 3587.1 1161.7 1167.0 1173.8 1217.5 1242.6 13923.8 14079.6 14263.6 15602.3 15784.3 4527.5 4617.1 4748.7 4776.0 4781.5 11632.0 11693.8 11697.1 11698.1 11726.5 5730.6 5783.2 5790.9 5792.9 5800.9 4087.0 5225.9 5245.1 5280.7 5292.4 2972.7 3401.0 3731.4 3738.3 3980.4 999.8 1026.7 1028.2 1041.3 1048.1 929.7 944.2 945.6 952.2 1004.5 6537.7 6605.6 6609.6 6819.5 6822.0 921.1 966.4 1005.2 1020.2 1068.1 4272.9 4274.4 4284.3 4330.6 4398.5 12767.6 13098.8 13120.0 13147.8 13163.5 12981.8 13203.0 13676.9 13870.7 13945.9 8686.7 8793.4 9405.0 9541.5 10327.2 6030.8 6743.8 6860.7 6891.3 6923.5 11906.5 11987.4 12207.5 12229.3 12232.4 10611.6 12396.3 12626.0 12807.7 12969.4 7103.7 9422.8 9513.0 9524.7 9541.5 10319.4 10477.8 10484.6 10487.8 10498.5 9083.5 9305.6 9332.8 9365.4 9400.7 6972.6 8896.0 9071.5 9174.8 9209.4 7920.5 7944.4 8059.8 8065.7 8144.1 5794.3 5812.1 5881.0 5943.1 5984.1 5840.1 5927.9 6126.8 6145.8 6257.0 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | [#4] prototype.html Cycles:180 Average:4796.97 Median:5251.29 stddev:1320.70 (25.1%) stddev-sans-first:1281.59 08:28:42 INFO - PROCESS | 1756 | Values: 353.3 361.4 372.5 377.7 393.1 4761.7 5074.3 5328.5 5358.9 5436.5 4197.8 4544.3 5077.8 5366.8 5372.5 4037.6 4048.7 4301.9 4308.6 4409.9 3420.6 3692.1 3948.6 4376.6 4415.6 3957.8 4466.8 4480.6 4506.8 4523.6 3321.5 3666.0 4099.5 4240.5 4475.9 3903.8 3993.2 4043.9 4077.8 4107.9 5137.9 5200.3 5220.6 5238.7 5243.7 4217.8 4346.5 4660.4 4767.6 4816.8 4930.7 5424.3 5744.8 5770.3 5852.8 4609.7 4633.3 4636.1 4640.7 4645.5 4945.3 5440.2 5700.0 5791.5 6121.6 4686.4 5221.9 5235.6 5245.8 5256.8 4815.9 5296.6 5346.0 5389.8 5419.7 4403.5 5335.8 5356.8 5468.3 5553.3 5402.8 5633.9 5642.5 5659.6 5667.7 1492.6 1575.7 1709.8 1743.4 1743.8 1251.7 1326.8 1350.6 1383.9 1469.6 4929.7 5159.9 5315.7 5351.5 5394.4 5273.8 5496.9 5623.0 5691.4 5911.7 4752.7 5019.0 5065.6 5352.0 5403.7 3091.5 3100.1 3100.8 3102.6 3105.6 5193.5 5407.7 5838.3 6164.0 6227.4 5453.7 5921.0 6004.4 6058.8 6059.8 4839.5 5532.5 6056.1 6075.3 6214.9 5653.4 5938.4 5938.9 6044.8 6049.5 4954.3 4992.6 5751.1 5966.9 5991.0 5558.9 5717.5 5751.6 5782.6 5982.5 4109.7 4669.0 5000.2 5179.5 5203.0 5025.6 5365.1 5546.0 5557.5 5974.1 5680.6 5697.6 5735.4 5769.7 5788.3 4978.0 5044.5 5493.9 5783.8 5803.8 5275.0 5551.5 5660.5 5696.0 5715.6 4988.4 5468.4 5833.2 5850.3 5859.4 5363.4 5470.5 5583.8 5629.9 5714.9 08:28:42 INFO - PROCESS | 1756 | 08:28:42 INFO - PROCESS | 1756 | [#5] yui.html Cycles:180 Average:20810.19 Median:4313.76 stddev:29389.44 (681.3%) stddev-sans-first:29432.86 08:28:42 INFO - PROCESS | 1756 | Values: 640.4 709.7 765.1 791.8 846.4 13162.7 15469.3 16161.6 16180.8 17080.7 15330.9 15725.0 15858.8 15930.5 15935.4 911.1 933.8 934.9 937.3 942.9 908.2 941.0 943.0 946.1 946.8 994.2 996.2 996.8 999.6 1000.6 980.7 986.7 987.2 989.1 990.0 726.4 734.7 735.0 735.2 736.6 15854.8 16167.4 16458.4 17035.6 17330.2 13948.4 14135.4 14255.6 14355.9 14464.5 9708.3 11719.4 11798.9 11904.2 12423.4 3078.5 3152.6 3614.4 3847.4 3850.1 74675.0 76513.6 78600.2 94916.0 111220.4 9045.0 10562.8 10993.2 11204.7 11498.3 21960.3 22032.1 22376.0 22502.9 22511.5 7787.3 7866.8 7868.6 7935.2 8142.6 3870.3 4277.3 4350.3 4382.8 4391.6 2710.4 3213.1 3467.0 3512.2 3554.4 642.1 644.1 651.5 657.3 658.8 663.2 668.4 689.2 700.3 723.3 9668.4 9936.2 10013.4 10079.8 10539.7 574.6 673.8 681.0 681.2 687.9 4685.7 5103.2 5112.9 5113.8 5288.4 90623.5 90751.0 110072.4 112432.6 115294.0 87914.0 89046.0 95857.5 99972.0 100261.0 74560.9 85292.6 88662.6 91874.5 92547.1 9469.7 10761.5 11348.5 11469.7 11598.4 54705.0 55461.7 55633.4 56073.2 57232.4 55291.0 71587.0 72467.8 73348.3 73821.0 10640.4 13849.3 14046.9 14288.7 14359.6 14934.5 15091.3 15305.6 16027.2 16139.8 12224.9 13747.0 14363.7 14565.5 14573.6 13799.6 13890.7 14302.7 14517.9 14894.7 11196.3 13856.4 14173.2 14368.5 14671.9 10840.8 11058.7 11382.9 11620.7 11883.2 9368.6 9613.6 11361.9 11664.6 11671.8 08:28:42 INFO - PROCESS | 1756 | -------- Summary: end -------- 08:28:42 INFO - PROCESS | 1756 | 08:28:43 INFO - TEST-INFO | 1756: exit 0 08:28:43 INFO - TEST-OK | dromaeo_css | took 1118364ms 08:28:43 INFO - TEST-START | kraken 08:28:43 INFO - operating with platform_type : mac_ 08:28:43 INFO - Initialising browser for kraken test... 08:28:43 INFO - TEST-INFO | started process 1765 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp4bwIEZ/profile http://localhost:49244/getInfo.html) 08:28:46 INFO - PROCESS | 1765 | 2017-03-12 08:28:46.304 plugin-container[1766:19846] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 08:28:46 INFO - PROCESS | 1765 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:28:46 INFO - PROCESS | 1765 | 2017-03-12 08:28:46.307 plugin-container[1766:19846] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 08:28:46 INFO - PROCESS | 1765 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:28:46 INFO - PROCESS | 1765 | 2017-03-12 08:28:46.307 plugin-container[1766:19846] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:28:46 INFO - PROCESS | 1765 | __metrics Screen width/height:1600/1200 08:28:46 INFO - PROCESS | 1765 | colorDepth:24 08:28:46 INFO - PROCESS | 1765 | Browser inner width/height: 1024/689 08:28:46 INFO - PROCESS | 1765 | __metrics 08:28:46 ERROR - PROCESS | 1765 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:28:47 INFO - TEST-INFO | 1765: exit 0 08:28:47 INFO - Browser initialized. 08:28:47 INFO - Running cycle 1/1 for kraken test... 08:28:47 INFO - TEST-INFO | started process 1767 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp4bwIEZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:49 INFO - PROCESS | 1767 | 2017-03-12 08:28:49.772 plugin-container[1768:19971] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 08:28:49 INFO - PROCESS | 1767 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:28:49 INFO - PROCESS | 1767 | 2017-03-12 08:28:49.772 plugin-container[1768:19971] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:28:49 INFO - PROCESS | 1767 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:28:49 INFO - PROCESS | 1767 | 2017-03-12 08:28:49.773 plugin-container[1768:19971] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:28:59 INFO - PROCESS | 1767 | RSS: Main: 220356608 08:28:59 INFO - PROCESS | 1767 | 08:29:02 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:03 INFO - PROCESS | 1767 | RSS: Main: 234860544 08:29:03 INFO - PROCESS | 1767 | 08:29:05 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 08:29:06 INFO - PROCESS | 1767 | RSS: Main: 243048448 08:29:06 INFO - PROCESS | 1767 | 08:29:09 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 08:29:10 INFO - PROCESS | 1767 | RSS: Main: 247091200 08:29:10 INFO - PROCESS | 1767 | 08:29:12 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 08:29:12 INFO - PROCESS | 1767 | RSS: Main: 248422400 08:29:12 INFO - PROCESS | 1767 | 08:29:14 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:15 INFO - PROCESS | 1767 | RSS: Main: 248557568 08:29:15 INFO - PROCESS | 1767 | 08:29:18 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:19 INFO - PROCESS | 1767 | RSS: Main: 252735488 08:29:19 INFO - PROCESS | 1767 | 08:29:22 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:23 INFO - PROCESS | 1767 | RSS: Main: 251637760 08:29:23 INFO - PROCESS | 1767 | 08:29:26 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 08:29:27 INFO - PROCESS | 1767 | RSS: Main: 252010496 08:29:27 INFO - PROCESS | 1767 | 08:29:28 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:29 INFO - PROCESS | 1767 | RSS: Main: 251301888 08:29:29 INFO - PROCESS | 1767 | 08:29:31 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:32 INFO - PROCESS | 1767 | RSS: Main: 251338752 08:29:32 INFO - PROCESS | 1767 | 08:29:34 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:34 INFO - PROCESS | 1767 | RSS: Main: 251359232 08:29:34 INFO - PROCESS | 1767 | 08:29:37 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:38 INFO - PROCESS | 1767 | RSS: Main: 251682816 08:29:38 INFO - PROCESS | 1767 | 08:29:41 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:42 INFO - PROCESS | 1767 | RSS: Main: 251535360 08:29:42 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 08:29:44 INFO - PROCESS | 1767 | RSS: Main: 253493248 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | __start_tp_report 08:29:44 INFO - PROCESS | 1767 | _x_x_mozilla_page_load 08:29:44 INFO - PROCESS | 1767 | _x_x_mozilla_page_load_details 08:29:44 INFO - PROCESS | 1767 | |i|pagename|runs| 08:29:44 INFO - PROCESS | 1767 | |0;ai-astar;109;123;120;119;121;118;126;177;119;118 08:29:44 INFO - PROCESS | 1767 | |1;audio-beat-detection;140;110;113;145;112;112;111;122;129;112 08:29:44 INFO - PROCESS | 1767 | |2;audio-dft;198;201;191;194;197;201;199;196;203;195 08:29:44 INFO - PROCESS | 1767 | |3;audio-fft;81;60;60;86;61;62;64;63;75;61 08:29:44 INFO - PROCESS | 1767 | |4;audio-oscillator;83;74;86;74;70;71;81;70;72;84 08:29:44 INFO - PROCESS | 1767 | |5;imaging-gaussian-blur;89;89;89;113;108;85;137;129;90;91 08:29:44 INFO - PROCESS | 1767 | |6;imaging-darkroom;98;98;97;97;98;98;98;97;156;97 08:29:44 INFO - PROCESS | 1767 | |7;imaging-desaturate;92;126;74;76;87;112;150;142;90;91 08:29:44 INFO - PROCESS | 1767 | |8;json-parse-financial;66;67;67;69;69;85;102;76;99;86 08:29:44 INFO - PROCESS | 1767 | |9;json-stringify-tinderbox;58;60;60;62;62;58;84;83;51;61 08:29:44 INFO - PROCESS | 1767 | |10;stanford-crypto-aes;88;84;86;89;100;89;88;89;90;87 08:29:44 INFO - PROCESS | 1767 | |11;stanford-crypto-ccm;149;151;146;145;139;129;133;154;169;143 08:29:44 INFO - PROCESS | 1767 | |12;stanford-crypto-pbkdf2;166;167;168;167;173;206;230;194;168;166 08:29:44 INFO - PROCESS | 1767 | |13;stanford-crypto-sha256-iterative;67;65;68;82;74;65;66;65;66;66 08:29:44 INFO - PROCESS | 1767 | __end_tp_report 08:29:44 INFO - PROCESS | 1767 | __start_cc_report 08:29:44 INFO - PROCESS | 1767 | _x_x_mozilla_cycle_collect,1011 08:29:44 INFO - PROCESS | 1767 | __end_cc_report 08:29:44 INFO - PROCESS | 1767 | __startTimestamp1489332584272__endTimestamp 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | ------- Summary: start ------- 08:29:44 INFO - PROCESS | 1767 | Number of tests: 14 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#0] ai-astar Cycles:10 Average:125.00 Median:120.50 stddev:18.79 (15.6%) stddev-sans-first:19.01 08:29:44 INFO - PROCESS | 1767 | Values: 109.0 123.0 120.0 119.0 121.0 118.0 126.0 177.0 119.0 118.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:117.50 stddev:13.03 (11.1%) stddev-sans-first:11.78 08:29:44 INFO - PROCESS | 1767 | Values: 140.0 110.0 113.0 145.0 112.0 112.0 111.0 122.0 129.0 112.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#2] audio-dft Cycles:10 Average:197.50 Median:198.50 stddev:3.66 (1.8%) stddev-sans-first:3.88 08:29:44 INFO - PROCESS | 1767 | Values: 198.0 201.0 191.0 194.0 197.0 201.0 199.0 196.0 203.0 195.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#3] audio-fft Cycles:10 Average:67.30 Median:63.50 stddev:9.66 (15.2%) stddev-sans-first:8.89 08:29:44 INFO - PROCESS | 1767 | Values: 81.0 60.0 60.0 86.0 61.0 62.0 64.0 63.0 75.0 61.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.50 stddev:6.29 (8.1%) stddev-sans-first:6.22 08:29:44 INFO - PROCESS | 1767 | Values: 83.0 74.0 86.0 74.0 70.0 71.0 81.0 70.0 72.0 84.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#5] imaging-gaussian-blur Cycles:10 Average:102.00 Median:89.00 stddev:18.77 (21.1%) stddev-sans-first:19.31 08:29:44 INFO - PROCESS | 1767 | Values: 89.0 89.0 89.0 113.0 108.0 85.0 137.0 129.0 90.0 91.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:98.00 stddev:18.49 (18.9%) stddev-sans-first:19.51 08:29:44 INFO - PROCESS | 1767 | Values: 98.0 98.0 97.0 97.0 98.0 98.0 98.0 97.0 156.0 97.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#7] imaging-desaturate Cycles:10 Average:104.00 Median:81.50 stddev:27.06 (33.2%) stddev-sans-first:28.35 08:29:44 INFO - PROCESS | 1767 | Values: 92.0 126.0 74.0 76.0 87.0 112.0 150.0 142.0 90.0 91.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#8] json-parse-financial Cycles:10 Average:78.60 Median:72.50 stddev:13.66 (18.8%) stddev-sans-first:13.70 08:29:44 INFO - PROCESS | 1767 | Values: 66.0 67.0 67.0 69.0 69.0 85.0 102.0 76.0 99.0 86.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:61.50 stddev:10.81 (17.6%) stddev-sans-first:11.25 08:29:44 INFO - PROCESS | 1767 | Values: 58.0 60.0 60.0 62.0 62.0 58.0 84.0 83.0 51.0 61.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:88.50 stddev:4.24 (4.8%) stddev-sans-first:4.48 08:29:44 INFO - PROCESS | 1767 | Values: 88.0 84.0 86.0 89.0 100.0 89.0 88.0 89.0 90.0 87.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:147.50 stddev:11.27 (7.6%) stddev-sans-first:11.90 08:29:44 INFO - PROCESS | 1767 | Values: 149.0 151.0 146.0 145.0 139.0 129.0 133.0 154.0 169.0 143.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:170.50 stddev:22.20 (13.0%) stddev-sans-first:22.92 08:29:44 INFO - PROCESS | 1767 | Values: 166.0 167.0 168.0 167.0 173.0 206.0 230.0 194.0 168.0 166.0 08:29:44 INFO - PROCESS | 1767 | 08:29:44 INFO - PROCESS | 1767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:66.50 stddev:5.48 (8.2%) stddev-sans-first:5.79 08:29:44 INFO - PROCESS | 1767 | Values: 67.0 65.0 68.0 82.0 74.0 65.0 66.0 65.0 66.0 66.0 08:29:44 INFO - PROCESS | 1767 | -------- Summary: end -------- 08:29:44 INFO - PROCESS | 1767 | 08:29:45 INFO - TEST-INFO | 1767: exit 0 08:29:45 INFO - TEST-OK | kraken | took 61804ms 08:29:45 INFO - SUITE-END | took 1180s 08:29:45 INFO - Completed test suite (00:19:40) 08:29:45 INFO - javascript benchmark 08:29:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7775.788747792171, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2942.9852850735742, 3515.964840351597, 3516.7538272320935, 3542.9114272143192, 3551.9112022199442, 6127.448529632332, 6151.938480615193, 6185.412385823345, 6205.813825585228, 6211.50307975362, 6148.600340977833, 6148.877022459548, 6182.041783523561, 6233.1273621693, 6233.657148856811, 5508.99999999999, 5538.972305138469, 5597.104463285875, 5664.376918538957, 5693.686847223401, 5689.943100568983, 5697.202391665171, 5706.429357064281, 5719.19931209631, 5745.540356771469, 5468.7539060742165, 5469.535089517396, 5528.944710552883, 5667.546596272288, 5676.347220069683, 5544.528715059225, 5622.100463925753, 5622.550195984332, 5683.318001839764, 5717.885642287131, 5451.3458384994055, 5598.916016259759, 5600.4959553640365, 5605.1872478490795, 5612.971935140339, 6205.81382558524, 6224.87550248997, 6277.2153480814895, 6288.496920246369, 6306.0, 6249.2813326467585, 6303.432691057827, 6310.116583678288, 6403.0715546246, 6433.195850518685, 6609.107770450975, 6634.601923884534, 6643.60138391698, 6663.433608143314, 6670.466362690973, 5236.6857988520815, 6227.0, 6283.874322513524, 6285.277193122758, 6299.307076221612, 6435.581687190318, 6511.218653761579, 6556.803295901131, 6767.458603311723, 6810.387065164159, 5529.391766905637, 6344.1118243445035, 6386.8722625547225, 6405.135306733531, 6419.390157934989, 6491.383318584727, 6614.04096406028, 6635.535512514078, 6637.435817955527, 6637.86724265512, 6256.593321434092, 6305.0, 6369.9681501592195, 6532.8366790830605, 6537.477001839841, 6299.96850015747, 6378.075179099004, 6420.775272865428, 6458.321876202931, 6549.705263263165, 5204.895902082013, 5217.6347655664495, 5261.5264626183825, 5295.920561191509, 5311.442298558596, 4665.836695715701, 4690.343351930733, 4716.834910778106, 4721.504242054535, 4808.182608956486, 6035.064564992434, 6104.603200791934, 6200.968995155085, 6207.255129384503, 6245.500359971192, 6447.6131432114225, 6471.7734879279, 6525.738970441129, 6531.412172904462, 6569.113169722026, 5077.8730531737, 6229.283632382243, 6241.313455519889, 6247.625142491465, 6288.056791481315, 5817.243758311392, 5827.35899051104, 5837.591368604157, 5854.18041474194, 5855.677937713382, 6535.869282614416, 6547.410733034049, 6709.329067093252, 6748.223954245324, 7022.43820494349, 6550.377714117151, 6649.867002660017, 6671.566348187353, 6672.132622759011, 6686.364795344434, 6793.6942837573415, 6824.590524568542, 6832.453403727591, 6838.076859624086, 6847.965760171366, 6288.465480434214, 6363.140975968185, 6418.133551970424, 6424.261209960914, 6530.412262896362, 6660.900086498609, 6675.899861502178, 6680.465562754871, 6691.2639609643875, 6700.329967003456, 6439.710213040331, 6452.387023232785, 6491.902621460587, 6498.935010650022, 6507.089007539043, 6256.624602523863, 6266.655333956676, 6295.811125666238, 6388.233411990591, 6481.4166724994975, 6128.319797384666, 6313.873722525615, 6318.115463835159, 6330.841728956813, 6348.016057511093, 6409.9359006411205, 6438.935610643834, 6454.934935735551, 6459.806205813833, 6464.41820236181, 6135.171422439309, 6230.252369715663, 6232.968835155795, 6235.220597425322, 6246.250449946036], "value": 6045.947704815852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.8026042838219, 800.8278220182659, 819.4264015189369, 955.3742298794292, 963.7686955130762, 38187.61812381876, 38853.61146388539, 40148.59851401492, 40178.995525111815, 40213.79358619243, 38884.80557597208, 38990.80504597473, 39108.41337379935, 39128.60871391292, 39158.608413915856, 7936.365090792751, 8068.475549089319, 10581.312214706059, 10900.50947707355, 11031.282966607145, 10747.355158690465, 10830.350178989247, 10831.891681083207, 10845.240833141683, 10847.566097356097, 10814.675559733221, 10839.0, 10853.023227909487, 10854.185936054788, 10857.67426977188, 10783.676489705282, 10792.082672972807, 10794.190435717313, 10812.080973117216, 10856.620018299362, 10545.525451354632, 10553.84169237462, 10561.207909406825, 10587.153027757839, 10597.576096956112, 33550.664493355, 33717.0, 33768.98693039188, 33820.323593528236, 33890.0, 2949.0710426215674, 3763.4354846773203, 3769.7738135711943, 3776.131489757344, 3833.7318484278126, 24920.626190607156, 25085.49829003428, 25388.11141610053, 26377.472450551075, 26415.075472358374, 3064.0960916529675, 3135.9059228222964, 3153.716165545089, 3173.428782819092, 3272.5582046423665, 357895.0, 367861.0, 368487.1575642105, 368962.0, 369576.0, 42460.7261782147, 42585.57414425878, 42610.57389426128, 42742.0, 42751.0, 36026.63973360285, 43344.78327608405, 44019.0, 44124.338134928, 44293.0, 12547.749045019049, 12616.747665046647, 12665.303408312631, 12670.80993785094, 12696.365181741061, 10745.194110441747, 10893.782124357469, 10894.237403381687, 10920.071793897449, 10951.247800351906, 11415.543378264943, 11427.200095993201, 11447.427628618703, 11464.713382165346, 11493.0, 5706.4864162225595, 5736.110902810071, 5811.912821307684, 5840.065589505659, 5843.298804143445, 849.796048948248, 933.5612262236738, 951.286535098676, 965.3194497878978, 990.0000998990927, 28047.439051218862, 28050.43899122006, 28130.859345703142, 28327.57508637372, 28562.85718571394, 1030.6341248856697, 1041.193075366597, 1066.8666416697913, 1075.4945175767534, 1079.5681727309138, 12653.683657908627, 12769.489220431264, 14161.362738676784, 14909.956303058898, 15622.9218853905, 387224.0, 387876.0, 388552.0, 389237.0, 393034.0, 51275.23087153696, 51614.48385516172, 51658.0, 51850.48149518532, 51977.96044079173, 1410.5133728863525, 1453.4476898778396, 1461.7368873602854, 1463.0563286680244, 1463.144060724488, 26169.0, 26640.0, 27461.45077098487, 27501.449971000868, 27753.306167345978, 43388.566114339716, 43416.78291608522, 43428.0, 43432.565674344114, 43510.34734479048, 359046.0, 360802.0, 360882.0, 361417.0, 362749.0, 28600.570991434728, 29388.7061129386, 30521.389572208875, 30621.23446913845, 30659.0, 37704.43443348407, 37776.81111594424, 38319.04202394962, 38570.80714596409, 38658.0, 32061.83969080233, 32317.0, 32328.83835580807, 33116.0, 33323.500147497325, 21208.469788255417, 26273.868630656725, 26905.461890762468, 31825.5226171603, 33526.497102543966, 26939.865300673373, 27281.863590681918, 31587.684123158473, 32120.0, 32261.87083452068, 26969.325766855985, 28978.7102128976, 29312.56031159577, 29415.705842941297, 29499.96750113736, 22494.0, 22525.662115068615, 22699.319020429415, 22756.886215568815, 22788.43028924224], "value": 17793.457110183077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.170543950589, 409.11834995584525, 411.17559293616296, 424.21096760026353, 452.7328875963181, 18070.367537136204, 19846.7022994655, 20233.696494552576, 20935.162593496243, 21469.67795483069, 21473.248436304693, 21498.247561335356, 21910.780892191113, 22451.77548224517, 22618.321450356514, 6052.122442245872, 6318.715657795387, 6702.731890724365, 6885.621290829003, 6890.793276201722, 6463.450606698436, 6606.174228221473, 6709.8322541936595, 6750.021246919194, 6790.0, 6435.613863168225, 6685.598864068147, 6719.6640167991645, 6774.898376524356, 6776.2546119926765, 6560.2455717592375, 6700.162479690039, 6702.36327548882, 6722.865542689167, 6729.7308107675635, 6237.968810155966, 6447.129637498924, 6557.3442655734525, 6592.86814263712, 6612.702428390686, 26341.07806226792, 26592.335191620172, 26665.600015999775, 26788.0, 26983.86508067447, 2856.157433557106, 2875.295552589608, 2994.3562134141266, 3024.228821650487, 3073.400686866062, 15922.920385398114, 16812.159392030473, 16837.579060523585, 17067.061311627855, 17420.47738567845, 2044.2742826296599, 2070.565181311926, 2071.9378418647316, 2072.347210628647, 2075.335892514396, 134277.0, 136120.0, 137783.0, 137924.31037844747, 139536.0, 22693.0, 22793.544129117327, 23076.076956921872, 23312.88343558305, 23353.0, 35306.82346588251, 35363.115922101635, 35703.64296357055, 36095.91712248637, 36096.639033609856, 9127.863082053775, 9201.447913125234, 9352.532373381304, 9355.391899526508, 9439.386439881386, 6143.508519318444, 7362.3373896349585, 7417.221191774894, 7455.403567714569, 7544.547327160388, 8692.913070869337, 10525.579046828734, 10585.57657693699, 10628.521716522775, 10721.571137154582, 3543.5924868639922, 4007.8196481158416, 4229.238737027303, 4397.802098905557, 4546.909061818811, 938.1884669760608, 947.7867479817124, 954.494118117385, 966.8018056298442, 983.7638966647953, 22129.557408852055, 23199.884000580227, 23316.883415583154, 23389.0, 23451.765482345298, 966.9371490853072, 967.8354679704468, 995.8954309797512, 1003.8644782954208, 1007.2898606482412, 8902.821943561223, 11517.82723259135, 12015.219010764273, 12212.32832194238, 12482.875171248172, 686214.0, 738585.0, 792631.0, 795436.0, 812806.0, 170361.14819425825, 170538.0, 173129.0, 173598.0, 174357.0, 1071.6302875507938, 1238.8885000350012, 1288.5296866643796, 1295.3264302562616, 1296.935153242334, 19491.610167796847, 19752.30866919651, 20108.99455027272, 20187.697184542536, 20192.88939108363, 63083.0, 66960.99558506529, 67304.0, 67456.6627166861, 68435.65782171057, 80762.0, 95575.04424955661, 96256.0, 98138.509307453, 99069.0, 9091.363604547618, 11443.48504317291, 11862.56817352458, 11899.107566932342, 11970.401479925795, 10819.891801081889, 12881.613551593467, 12954.870451295366, 13183.40674669623, 13191.934040329737, 11071.003609674846, 11275.830862537232, 11406.372649504357, 11476.368799716096, 11565.248258863146, 11127.499262533367, 11315.886841131483, 11387.658370248906, 11431.771364572496, 11733.413329333329, 11493.942530287295, 11787.351695656822, 11881.762364752829, 11884.227525210834, 11930.880691192977, 11561.710957226136, 11916.761664766484, 11957.820632690691, 11968.820467692818, 11990.580329688419, 11391.829122563335, 11521.711957201138, 11700.824487632523, 11749.706257343634, 11792.938635522843], "value": 11731.197784689592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.4552869909433, 1535.240056172195, 1536.5390382885146, 1561.7193901001176, 1581.3358389476418, 10715.571377144915, 11193.944030279858, 11296.265742726717, 11308.830367544493, 11554.364509951949, 11278.492467838947, 11436.313821170716, 11447.713807154825, 11456.541738330458, 11502.964733174013, 2393.688820453339, 2419.129113519132, 2433.5497932882386, 2433.634954756792, 2435.7320694723567, 2357.764223577637, 2396.1373905394044, 2397.4006498375406, 2400.2799160251943, 2402.939926501834, 2404.651325557793, 2419.6491508731224, 2424.3211900667843, 2428.9149879754214, 2443.9022439102414, 2381.6784734060852, 2388.7969522590515, 2403.42317843718, 2406.2059520358325, 2407.4462873539183, 2353.717553893544, 2355.0815182079004, 2373.0389192377115, 2411.1560953666253, 2412.1798588479824, 11263.943680281629, 11312.151588630803, 11313.0, 11317.603883864107, 11330.546778128864, 5749.741261643236, 5886.0, 5957.285125784891, 5964.075568286922, 5971.641701497924, 3116.0496048705136, 3450.5341778859784, 3538.327717733622, 3567.019069755838, 3587.121155316938, 1161.7211869151427, 1166.9533218671243, 1173.7652469506133, 1217.5008246618843, 1242.6085782978332, 13923.791143132963, 14079.648008799759, 14263.643408914757, 15602.29789659468, 15784.289706963214, 4527.456705195397, 4617.145828021827, 4748.738819364969, 4776.0, 4781.450133234723, 11632.0, 11693.766124677459, 11697.064234861191, 11698.06415486776, 11726.472308746126, 5730.570207234474, 5783.248177736868, 5790.942090579125, 5792.913106303409, 5800.9129863052085, 4086.959130408717, 5225.895482090337, 5245.10833158364, 5280.709560974184, 5292.417834038252, 2972.658144313388, 3401.013706025225, 3731.421629647409, 3738.2710371477847, 3980.4228386883738, 999.7500624843789, 1026.697124348319, 1028.1620479309338, 1041.2763129624989, 1048.1248157788332, 929.6560272699145, 944.17856464876, 945.6264775413673, 952.1953948913157, 1004.5128112865254, 6537.705803238866, 6605.57063790852, 6609.6364699941005, 6819.522633415613, 6822.044913712084, 921.0513171433435, 966.3525437956446, 1005.2058873489862, 1020.1889497849079, 1068.1348108032519, 4272.9359059614135, 4274.380214868826, 4284.2930916398445, 4330.631896288788, 4398.47218333802, 12767.553135640208, 13098.803517947239, 13119.95040396766, 13147.802782958262, 13163.53927612529, 12981.805272920914, 13203.0, 13676.93161534186, 13870.722585548434, 13945.860541394457, 8686.695965641173, 8793.428427152214, 9404.95297523508, 9541.47521886303, 10327.173826093895, 6030.849228769316, 6743.79768606923, 6860.6912688930115, 6891.345322194384, 6923.515353925177, 11906.523739050688, 11987.400629968291, 12207.45066471993, 12229.3273869938, 12232.388380581113, 10611.575536978744, 12396.31820249895, 12626.0, 12807.743845123232, 12969.35153242353, 7103.680334385069, 9422.764430889283, 9512.95243523778, 9524.666636667684, 9541.473364261685, 10319.432431216355, 10477.790444191225, 10484.580616775243, 10487.842682359618, 10498.475076246004, 9083.545822708971, 9305.581248843682, 9332.81334373295, 9365.391249568756, 9400.717978460658, 6972.616506092214, 8896.0, 9071.546422678972, 9174.816503670023, 9209.401388909699, 7920.485168464032, 7944.364450843803, 8059.758207253792, 8065.717699880476, 8144.104148543774, 5794.275715535558, 5812.099124635688, 5880.970595146997, 5943.078822782476, 5984.102384642339, 5840.123981402823, 5927.85180370477, 6126.846828829315, 6145.754169833157, 6257.0], "value": 5129.516663836086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.34983630120576, 361.38023290057555, 372.45249483259613, 377.6865201882438, 393.1037235103963, 4761.690490118149, 5074.314967479389, 5328.53465297043, 5358.892822143554, 5436.456354364562, 4197.79011049447, 4544.3183522471645, 5077.796888124471, 5366.812161574346, 5372.54333381663, 4037.596240375968, 4048.716589838698, 4301.946023224315, 4308.569143085698, 4409.8754817521485, 3420.572428446444, 3692.1138926657545, 3948.644621984021, 4376.584224498668, 4415.646748260131, 3957.76253424794, 4466.754328511931, 4480.611010586712, 4506.805696490433, 4523.638108951292, 3321.4519604265265, 3666.0203490115305, 4099.528554216244, 4240.473429565354, 4475.932861007088, 3903.7703123516003, 3993.1614360984227, 4043.8584649537124, 4077.7970498702953, 4107.876763697094, 5137.921036582322, 5200.323957885488, 5220.6084543659, 5238.659487133325, 5243.659162154448, 4217.768022758747, 4346.500152482474, 4660.39414876064, 4767.570918617341, 4816.831410900601, 4930.704157750511, 5424.267723857308, 5744.798932037401, 5770.336411312711, 5852.795152169653, 4609.677322587387, 4633.2818413146015, 4636.09596128755, 4640.651951103647, 4645.488996210414, 4945.258211268302, 5440.211169380417, 5699.960548722366, 5791.478766910998, 6121.632702037892, 4686.437627484724, 5221.895562088737, 5235.607329450307, 5245.816396426107, 5256.763445644955, 4815.855524334275, 5296.629235953524, 5346.0281937797445, 5389.838304850782, 5419.674819510842, 4403.515613282536, 5335.813246536352, 5356.812511562077, 5468.343798744176, 5553.250311207935, 5402.812340718995, 5633.873225354945, 5642.548596112383, 5659.603827732019, 5667.716614169275, 1492.641765976158, 1575.6769862178226, 1709.8204688507528, 1743.378657848188, 1743.7907451105948, 1251.718363368253, 1326.820879181298, 1350.6291114518772, 1383.9100458470168, 1469.6472846516758, 4929.654924155275, 5159.922601160985, 5315.7042633567435, 5351.464853514617, 5394.433584473652, 5273.841784746463, 5496.890062198733, 5623.0, 5691.373948865621, 5911.674857882772, 4752.7385993769985, 5018.971110922253, 5065.6200784941275, 5352.0, 5403.675779453167, 3091.5053591425262, 3100.093442532826, 3100.8294543800307, 3102.602650098139, 3105.5714371388963, 5193.532582067632, 5407.729613519308, 5838.2702162229725, 6164.0, 6227.439530442282, 5453.672779633234, 5920.970395147997, 6004.369541198112, 6058.848528786727, 6059.818725079681, 4839.467658557556, 5532.502074813206, 6056.121862330026, 6075.301340345828, 6214.875702485834, 5653.378128405954, 5938.435848594377, 5938.910916336345, 6044.788432405021, 6049.455549000611, 4954.266006897557, 4992.5756310714, 5751.079827227623, 5966.8961242170335, 5990.981533139289, 5558.861028474321, 5717.5425965921795, 5751.562109472632, 5782.624129431573, 5982.521398288213, 4109.671226301948, 4669.0, 5000.174971129868, 5179.48205179479, 5202.959408118467, 5025.623078269217, 5365.141577347606, 5546.0, 5557.527610153021, 5974.116824064393, 5680.630759000652, 5697.607005057968, 5735.426457354231, 5769.68266745333, 5788.305403351625, 4978.0, 5044.520770526794, 5493.862653433536, 5783.768649253982, 5803.7678492861505, 5275.0, 5551.500364967173, 5660.462256085665, 5695.952665324032, 5715.628484148517, 4988.401391832858, 5468.418186088119, 5833.183354330312, 5850.338096166319, 5859.384764599826, 5363.356397232357, 5470.452954704498, 5583.804566840141, 5629.915551266816, 5714.885702286014], "value": 4415.067603891112, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.3820313397571, 709.711872950595, 765.0971853213209, 791.7624712586223, 846.3736834742291, 13162.736745265089, 15469.303881325339, 16161.595960100989, 16180.83819161808, 17080.658386832256, 15330.923345383286, 15725.0, 15858.841411585881, 15930.522084337488, 15935.44225952092, 911.0661571888801, 933.8039011807529, 934.8644446555245, 937.3063932689795, 942.9339946203769, 908.1917093786535, 941.0448394879203, 943.0428115462811, 946.1106559833769, 946.7585765629755, 994.22450488619, 996.2229461020415, 996.7707427291728, 999.605155963394, 1000.6447711062577, 980.6910823090703, 986.7434467038549, 987.1757082835804, 989.1493315748487, 990.0050449298409, 726.4079774983371, 734.6951015328632, 735.0040694858496, 735.1912895814561, 736.5948728199469, 15854.841451585567, 16167.353305867751, 16458.42395516151, 17035.574110647332, 17330.220140093727, 13948.442062317496, 14135.363908624136, 14255.643608909757, 14355.928220358936, 14464.49374271906, 9708.271879609058, 11719.414029298501, 11798.88201117995, 11904.226225295328, 12423.44094515749, 3078.5064098080625, 3152.6059242594674, 3614.4036234021355, 3847.442120892455, 3850.095227621535, 74675.0, 76513.61743191304, 78600.21399786044, 94916.0, 111220.4438977808, 9044.959829619678, 10562.788744225072, 10993.230473866752, 11204.719882003015, 11498.25261358009, 21960.34118976433, 22032.11871525153, 22376.0, 22502.887485562467, 22511.549769004527, 7787.260210280015, 7866.7639970800965, 7868.567228802356, 7935.166807485246, 8142.633581488847, 3870.283997460479, 4277.251480990876, 4350.260455722471, 4382.846600368972, 4391.6486681065435, 2710.3901622134863, 3213.068210219057, 3466.9826650866585, 3512.24486735348, 3554.3779838528153, 642.0818229931243, 644.0982624325981, 651.4885814635583, 657.3196741372752, 658.7957733102753, 663.1809715001968, 668.4151367553391, 689.1661090080958, 700.3206889317354, 723.2875617516742, 9668.371555848847, 9936.238573176312, 10013.39568051558, 10079.799237220479, 10539.683809485728, 574.6351067072355, 673.8342667185698, 680.9625470599066, 681.1553673444992, 687.9449644028466, 4685.691002777604, 5103.157978933508, 5112.8721781955, 5113.795448182031, 5288.365396152486, 90623.54688226516, 90751.0, 110072.4496377513, 112432.56743256743, 115294.0, 87914.0, 89046.0, 95857.52071239598, 99972.0, 100261.0, 74560.88158677732, 85292.57353713192, 88662.55668721744, 91874.54062729643, 92547.07452925519, 9469.715908522756, 10761.46192690378, 11348.546058157912, 11469.655910322703, 11598.420078995847, 54705.0, 55461.72269138628, 55633.44366556282, 56073.15890261731, 57232.42767572438, 55291.0, 71587.0, 72467.82596522113, 73348.26651733414, 73821.0, 10640.414777187329, 13849.307534623431, 14046.929765351108, 14288.714225715636, 14359.569212923629, 14934.497380394507, 15091.320890559731, 15305.6173595661, 16027.198640068184, 16139.75790363169, 12224.92670519305, 13747.037707360389, 14363.712725745636, 14565.490207842675, 14573.562793116223, 13799.586012419644, 13890.652733681334, 14302.71394572082, 14517.927410362881, 14894.702105958037, 11196.328220306808, 13856.376463058985, 14173.22047287409, 14368.497102601359, 14671.926640367157, 10840.837387439036, 11058.723531911766, 11382.94308528452, 11620.6513804586, 11883.227590206954, 9368.625254989724, 9613.615455381707, 11361.943190284326, 11664.591739289084, 11671.824922625998], "value": 7733.00882759874, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 123.0, 120.0, 119.0, 121.0, 118.0, 126.0, 177.0, 119.0, 118.0], "value": 125.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 113.0, 145.0, 112.0, 112.0, 111.0, 122.0, 129.0, 112.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 201.0, 191.0, 194.0, 197.0, 201.0, 199.0, 196.0, 203.0, 195.0], "value": 197.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 86.0, 61.0, 62.0, 64.0, 63.0, 75.0, 61.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 74.0, 86.0, 74.0, 70.0, 71.0, 81.0, 70.0, 72.0, 84.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 113.0, 108.0, 85.0, 137.0, 129.0, 90.0, 91.0], "value": 102.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 97.0, 97.0, 98.0, 98.0, 98.0, 97.0, 156.0, 97.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 126.0, 74.0, 76.0, 87.0, 112.0, 150.0, 142.0, 90.0, 91.0], "value": 104.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 69.0, 69.0, 85.0, 102.0, 76.0, 99.0, 86.0], "value": 78.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 60.0, 62.0, 62.0, 58.0, 84.0, 83.0, 51.0, 61.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 86.0, 89.0, 100.0, 89.0, 88.0, 89.0, 90.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 146.0, 145.0, 139.0, 129.0, 133.0, 154.0, 169.0, 143.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 168.0, 167.0, 173.0, 206.0, 230.0, 194.0, 168.0, 166.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 68.0, 82.0, 74.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 68.4, "unit": "score"}]}]} 08:29:45 INFO - Return code: 0 08:29:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:45 ERROR - # TBPL SUCCESS # 08:29:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:29:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:29:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:29:45 INFO - 2017-03-12 08:29:45.618 screenresolution[1772:20364] starting screenresolution argv=screenresolution get 08:29:45 INFO - 2017-03-12 08:29:45.621 screenresolution[1772:20364] Display 0: 1600x1200x32@60 08:29:45 INFO - 2017-03-12 08:29:45.627 screenresolution[1773:20367] starting screenresolution argv=screenresolution list 08:29:45 INFO - Available Modes on Display 0 08:29:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:29:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:29:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:29:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:29:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:29:45 INFO - Intel Iris: 08:29:45 INFO - Chipset Model: Intel Iris 08:29:45 INFO - Type: GPU 08:29:45 INFO - Bus: Built-In 08:29:45 INFO - VRAM (Dynamic, Max): 1536 MB 08:29:45 INFO - Vendor: Intel (0x8086) 08:29:45 INFO - Device ID: 0x0a2e 08:29:45 INFO - Revision ID: 0x0009 08:29:45 INFO - Displays: 08:29:45 INFO - Display: 08:29:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:29:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:29:45 INFO - Display Serial Number: 1600x1200 60 08:29:45 INFO - Main Display: Yes 08:29:45 INFO - Mirror: Off 08:29:45 INFO - Online: Yes 08:29:45 INFO - Rotation: Supported 08:29:45 INFO - Return code: 0 08:29:45 INFO - Running post-action listener: _resource_record_post_action 08:29:45 INFO - [mozharness: 2017-03-12 15:29:45.867195Z] Finished run-tests step (success) 08:29:45 INFO - Running post-run listener: _resource_record_post_run 08:29:45 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 33165824; Write bytes: 515864576; Read time: 201; Write time: 1609 08:29:45 INFO - TinderboxPrint: CPU usage
54.4% 08:29:45 INFO - TinderboxPrint: I/O read bytes / time
33,165,824 / 201 08:29:45 INFO - TinderboxPrint: I/O write bytes / time
515,864,576 / 1,609 08:29:45 INFO - TinderboxPrint: CPU idle
2,190.3 (45.6%) 08:29:45 INFO - TinderboxPrint: CPU system
961.1 (20.0%) 08:29:45 INFO - TinderboxPrint: CPU user
1,654.4 (34.4%) 08:29:45 INFO - TinderboxPrint: Swap in / out
237,481,984 / 0 08:29:45 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204139008; Write bytes: 202573824; Read time: 15641; Write time: 422 08:29:45 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31126016; Write bytes: 302338048; Read time: 180; Write time: 1150 08:29:46 INFO - Running post-run listener: _upload_blobber_files 08:29:46 INFO - Blob upload gear active. 08:29:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:46 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 08:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:29:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:29:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:29:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:47 INFO - (blobuploader) - INFO - Done attempting. 08:29:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:29:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:48 INFO - (blobuploader) - INFO - Done attempting. 08:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:49 INFO - (blobuploader) - INFO - Done attempting. 08:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:51 INFO - (blobuploader) - INFO - Done attempting. 08:29:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:51 INFO - Return code: 0 08:29:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d215914639c384d2c7b86474621e4ee13cb62e6bd8efffc8ed71ce1ade1030283a14cb995d4f408d47adec99e38914e4be968680be5b07918a5fa81505e99c19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f484a5f147c1eb98fb79e33bb85ac91b67b7273911c95b8d3484bdc0c9295cf00425120f2b800599432645e5b3a792785ab5b6a7957203cd783505aad577d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4679a594cd9da5554ec48d36b624d17e980b7e81c843a12390ba19da7b3bd326e7ad5726b462fcc58dee15a0a4c1b5f5d0683bdd985ea7e1d7aa4e10f82a228d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00da3b0eb7b37cbe4ca1b7e062ca0916b41809fb4596c2db9da4c115643b63ef0aa359c357db3352f791ef33a50566fc70d10461ce8f4fa71bd4eaba66095283"} 08:29:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:51 INFO - Contents: 08:29:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d215914639c384d2c7b86474621e4ee13cb62e6bd8efffc8ed71ce1ade1030283a14cb995d4f408d47adec99e38914e4be968680be5b07918a5fa81505e99c19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f484a5f147c1eb98fb79e33bb85ac91b67b7273911c95b8d3484bdc0c9295cf00425120f2b800599432645e5b3a792785ab5b6a7957203cd783505aad577d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4679a594cd9da5554ec48d36b624d17e980b7e81c843a12390ba19da7b3bd326e7ad5726b462fcc58dee15a0a4c1b5f5d0683bdd985ea7e1d7aa4e10f82a228d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00da3b0eb7b37cbe4ca1b7e062ca0916b41809fb4596c2db9da4c115643b63ef0aa359c357db3352f791ef33a50566fc70d10461ce8f4fa71bd4eaba66095283"} 08:29:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:51 INFO - Copying logs to upload dir... 08:29:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.930287 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-12 08:29:51.839189) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-12 08:29:51.843019) ========= 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.6V8sE6UIm8/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.hm3UjrukdN/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d215914639c384d2c7b86474621e4ee13cb62e6bd8efffc8ed71ce1ade1030283a14cb995d4f408d47adec99e38914e4be968680be5b07918a5fa81505e99c19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f484a5f147c1eb98fb79e33bb85ac91b67b7273911c95b8d3484bdc0c9295cf00425120f2b800599432645e5b3a792785ab5b6a7957203cd783505aad577d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4679a594cd9da5554ec48d36b624d17e980b7e81c843a12390ba19da7b3bd326e7ad5726b462fcc58dee15a0a4c1b5f5d0683bdd985ea7e1d7aa4e10f82a228d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00da3b0eb7b37cbe4ca1b7e062ca0916b41809fb4596c2db9da4c115643b63ef0aa359c357db3352f791ef33a50566fc70d10461ce8f4fa71bd4eaba66095283"} build_url:https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/bnKQkXa2TrCIMTNeyszS8g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d215914639c384d2c7b86474621e4ee13cb62e6bd8efffc8ed71ce1ade1030283a14cb995d4f408d47adec99e38914e4be968680be5b07918a5fa81505e99c19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f484a5f147c1eb98fb79e33bb85ac91b67b7273911c95b8d3484bdc0c9295cf00425120f2b800599432645e5b3a792785ab5b6a7957203cd783505aad577d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4679a594cd9da5554ec48d36b624d17e980b7e81c843a12390ba19da7b3bd326e7ad5726b462fcc58dee15a0a4c1b5f5d0683bdd985ea7e1d7aa4e10f82a228d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00da3b0eb7b37cbe4ca1b7e062ca0916b41809fb4596c2db9da4c115643b63ef0aa359c357db3352f791ef33a50566fc70d10461ce8f4fa71bd4eaba66095283"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-12 08:29:51.883548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:29:51.883871) ========= 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.6V8sE6UIm8/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.hm3UjrukdN/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005048 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 08:29:51.932698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-12 08:29:51.933005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-12 08:29:51.933338) ========= ========= Total master_lag: 0.19 =========