builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0070 starttime: 1486491920.23 results: success (0) buildid: 20170207083756 builduid: ef3377da9e7d41a2bf1b92b405258790 revision: 514a5268030faf927430313a96a9e470e5c14c11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.234480) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.234986) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.235274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.259710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.260137) ========= 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.0eQqOQNkzs/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.DtZObXscE9/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-07 10:25:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.72M=0.002s 2017-02-07 10:25:20 (7.72 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097477 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.381180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.381577) ========= 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.0eQqOQNkzs/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.DtZObXscE9/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.022465 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:20.430041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 10:25:20.430423) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 514a5268030faf927430313a96a9e470e5c14c11 --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 514a5268030faf927430313a96a9e470e5c14c11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0eQqOQNkzs/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.DtZObXscE9/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-07 10:25:20,516 truncating revision to first 12 chars 2017-02-07 10:25:20,516 Setting DEBUG logging. 2017-02-07 10:25:20,516 attempt 1/10 2017-02-07 10:25:20,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/514a5268030f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 10:25:21,973 unpacking tar archive at: mozilla-aurora-514a5268030f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.714023 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 10:25:22.167878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:22.168291) ========= script_repo_revision: 514a5268030faf927430313a96a9e470e5c14c11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:22.168716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:22.168993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 10:25:22.188576) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-07 10:25:22.188937) ========= /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.0eQqOQNkzs/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.DtZObXscE9/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:25:22 INFO - MultiFileLogger online at 20170207 10:25:22 in /builds/slave/test 10:25:22 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 10:25:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:25:22 INFO - {'append_to_log': False, 10:25:22 INFO - 'base_work_dir': '/builds/slave/test', 10:25:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:25:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:25:22 INFO - 'branch': 'Mozilla-Aurora', 10:25:22 INFO - 'buildbot_json_path': 'buildprops.json', 10:25:22 INFO - 'config_files': ('talos/mac_config.py',), 10:25:22 INFO - 'default_actions': ('clobber', 10:25:22 INFO - 'read-buildbot-config', 10:25:22 INFO - 'download-and-extract', 10:25:22 INFO - 'populate-webroot', 10:25:22 INFO - 'create-virtualenv', 10:25:22 INFO - 'install', 10:25:22 INFO - 'run-tests'), 10:25:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:25:22 INFO - 'download_minidump_stackwalk': True, 10:25:22 INFO - 'download_symbols': 'ondemand', 10:25:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:25:22 INFO - 'tooltool.py': '/tools/tooltool.py', 10:25:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:25:22 INFO - '/tools/misc-python/virtualenv.py')}, 10:25:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:25:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:25:22 INFO - 'installer_path': 'installer.exe', 10:25:22 INFO - 'log_level': 'info', 10:25:22 INFO - 'log_name': 'talos', 10:25:22 INFO - 'log_to_console': True, 10:25:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:25:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:25:22 INFO - 'opt_config_files': (), 10:25:22 INFO - 'pip_index': False, 10:25:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:22 INFO - 'cmd': ('bash', 10:25:22 INFO - '-c', 10:25:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:22 INFO - 'enabled': True, 10:25:22 INFO - 'halt_on_failure': False, 10:25:22 INFO - 'name': 'check_screen_resolution'},), 10:25:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:22 INFO - 'cmd': ('bash', 10:25:22 INFO - '-c', 10:25:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:22 INFO - 'enabled': True, 10:25:22 INFO - 'halt_on_failure': False, 10:25:22 INFO - 'name': 'check_screen_resolution'},), 10:25:22 INFO - 'run_cmd_checks_enabled': True, 10:25:22 INFO - 'sps_profile': False, 10:25:22 INFO - 'sps_profile_interval': 0, 10:25:22 INFO - 'suite': 'dromaeojs-e10s', 10:25:22 INFO - 'system_bits': '32', 10:25:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:25:22 INFO - 'title': 't-yosemite-r7-0070', 10:25:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:25:22 INFO - 'use_talos_json': True, 10:25:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:25:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:25:22 INFO - 'work_dir': 'build'} 10:25:22 INFO - [mozharness: 2017-02-07 18:25:22.403781Z] Running clobber step. 10:25:22 INFO - Running pre-action listener: _resource_record_pre_action 10:25:22 INFO - Running main action method: clobber 10:25:22 INFO - rmtree: /builds/slave/test/build 10:25:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:25:24 INFO - Running post-action listener: _resource_record_post_action 10:25:24 INFO - [mozharness: 2017-02-07 18:25:24.613994Z] Finished clobber step (success) 10:25:24 INFO - [mozharness: 2017-02-07 18:25:24.614125Z] Running read-buildbot-config step. 10:25:24 INFO - Running pre-action listener: _resource_record_pre_action 10:25:24 INFO - Running main action method: read_buildbot_config 10:25:24 INFO - Using buildbot properties: 10:25:24 INFO - { 10:25:24 INFO - "project": "", 10:25:24 INFO - "product": "firefox", 10:25:24 INFO - "script_repo_revision": "production", 10:25:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:25:24 INFO - "repository": "", 10:25:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:25:24 INFO - "buildid": "20170207083756", 10:25:24 INFO - "pgo_build": "False", 10:25:24 INFO - "basedir": "/builds/slave/test", 10:25:24 INFO - "buildnumber": 49, 10:25:24 INFO - "slavename": "t-yosemite-r7-0070", 10:25:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:25:24 INFO - "platform": "yosemite_r7", 10:25:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:25:24 INFO - "branch": "mozilla-aurora", 10:25:24 INFO - "repo_path": "releases/mozilla-aurora", 10:25:24 INFO - "revision": "514a5268030faf927430313a96a9e470e5c14c11", 10:25:24 INFO - "stage_platform": "macosx64", 10:25:24 INFO - "builduid": "ef3377da9e7d41a2bf1b92b405258790", 10:25:24 INFO - "slavebuilddir": "test" 10:25:24 INFO - } 10:25:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 10:25:24 INFO - Running post-action listener: _resource_record_post_action 10:25:24 INFO - [mozharness: 2017-02-07 18:25:24.618090Z] Finished read-buildbot-config step (success) 10:25:24 INFO - [mozharness: 2017-02-07 18:25:24.618224Z] Running download-and-extract step. 10:25:24 INFO - Running pre-action listener: _resource_record_pre_action 10:25:24 INFO - Running main action method: download_and_extract 10:25:24 INFO - mkdir: /builds/slave/test/build/tests 10:25: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')]} 10:25:24 INFO - trying https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 10:25:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 10:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 10:25:26 INFO - Downloaded 1199 bytes. 10:25:26 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 10:25:26 INFO - Using the following test package requirements: 10:25:26 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 10:25:26 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 10:25:26 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 10:25:26 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'jsshell-mac.zip'], 10:25:26 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 10:25:26 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 10:25:26 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 10:25:26 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 10:25:26 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 10:25:26 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:25:26 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 10:25:26 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:25:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 10:25:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:25:26 INFO - Fetch https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 10:25:27 INFO - Expected file size: 16357326 10:25:27 INFO - Obtained file size: 16357326 10:25:33 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:25:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 10:25:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:25:33 INFO - Fetch https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 10:25:34 INFO - Expected file size: 16357326 10:25:34 INFO - Obtained file size: 16357326 10:25:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 10:25:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:25:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 10:25:42 INFO - Expected file size: 14403485 10:25:42 INFO - Obtained file size: 14403485 10:25: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')]} 10:25:43 INFO - trying https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 10:25:43 INFO - Downloading https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 10:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 10:25:45 INFO - Downloaded 73820613 bytes. 10:25:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 10:25:45 INFO - mkdir: /builds/slave/test/properties 10:25:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:25:45 INFO - Writing to file /builds/slave/test/properties/build_url 10:25:45 INFO - Contents: 10:25:45 INFO - build_url:https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 10:25:46 INFO - Running post-action listener: _resource_record_post_action 10:25:46 INFO - Running post-action listener: set_extra_try_arguments 10:25:46 INFO - [mozharness: 2017-02-07 18:25:46.143182Z] Finished download-and-extract step (success) 10:25:46 INFO - [mozharness: 2017-02-07 18:25:46.143314Z] Running populate-webroot step. 10:25:46 INFO - Running pre-action listener: _resource_record_pre_action 10:25:46 INFO - Running main action method: populate_webroot 10:25:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:25:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:25:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:25:46 INFO - '--tppagecycles', 10:25:46 INFO - '7'], 10:25:46 INFO - 'tests': ['tsvgm']}}, 10:25:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:25:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:25:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:25:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:25:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:25:46 INFO - 'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:25:46 INFO - 'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['damp', 'tps']}, 10:25:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:25:46 INFO - 'tests': ['damp', 'tps']}, 10:25:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['dromaeo_dom']}, 10:25:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:25:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['basic_compositor_video']}, 10:25:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:25:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['a11yr', 10:25:46 INFO - 'ts_paint', 10:25:46 INFO - 'tpaint', 10:25:46 INFO - 'sessionrestore', 10:25:46 INFO - 'sessionrestore_no_auto_restore', 10:25:46 INFO - 'tabpaint']}, 10:25:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:25:46 INFO - 'ts_paint', 10:25:46 INFO - 'tpaint', 10:25:46 INFO - 'sessionrestore', 10:25:46 INFO - 'sessionrestore_no_auto_restore', 10:25:46 INFO - 'tabpaint']}, 10:25:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:25:46 INFO - 'ts_paint', 10:25:46 INFO - 'tpaint', 10:25:46 INFO - 'sessionrestore', 10:25:46 INFO - 'sessionrestore_no_auto_restore', 10:25:46 INFO - 'tabpaint']}, 10:25:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:25:46 INFO - 'ts_paint', 10:25:46 INFO - 'tpaint', 10:25:46 INFO - 'sessionrestore', 10:25:46 INFO - 'sessionrestore_no_auto_restore', 10:25:46 INFO - 'tabpaint']}, 10:25:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['a11yr', 10:25:46 INFO - 'ts_paint', 10:25:46 INFO - 'tpaint', 10:25:46 INFO - 'sessionrestore', 10:25:46 INFO - 'sessionrestore_no_auto_restore', 10:25:46 INFO - 'tabpaint']}, 10:25:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['a11yr', 10:25:46 INFO - 'ts_paint', 10:25:46 INFO - 'tpaint', 10:25:46 INFO - 'sessionrestore', 10:25:46 INFO - 'sessionrestore_no_auto_restore', 10:25:46 INFO - 'tabpaint']}, 10:25:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['tsvgx', 10:25:46 INFO - 'tsvgr_opacity', 10:25:46 INFO - 'tart', 10:25:46 INFO - 'tscrollx', 10:25:46 INFO - 'cart', 10:25:46 INFO - 'tsvg_static']}, 10:25:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:25:46 INFO - 'tsvgr_opacity', 10:25:46 INFO - 'tart', 10:25:46 INFO - 'tscrollx', 10:25:46 INFO - 'cart', 10:25:46 INFO - 'tsvg_static']}, 10:25:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:25:46 INFO - 'talos_options': ['--disable-e10s'], 10:25:46 INFO - 'tests': ['tp5o']}, 10:25:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:25:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:25:46 INFO - 'talos_options': ['--disable-e10s', 10:25:46 INFO - '--xperf_path', 10:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:46 INFO - 'tests': ['tp5n']}, 10:25:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:25:46 INFO - 'talos_options': ['--xperf_path', 10:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:46 INFO - 'tests': ['tp5n']}}, 10:25:46 INFO - 'talos.zip': {'path': '', 10:25:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:25:46 INFO - Running post-action listener: _resource_record_post_action 10:25:46 INFO - [mozharness: 2017-02-07 18:25:46.162014Z] Finished populate-webroot step (success) 10:25:46 INFO - [mozharness: 2017-02-07 18:25:46.162139Z] Running create-virtualenv step. 10:25:46 INFO - Running pre-action listener: _resource_record_pre_action 10:25:46 INFO - Running main action method: create_virtualenv 10:25:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:25:46 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 10:25:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:25:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:25:46 INFO - Using real prefix '/tools/python27' 10:25:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:25:46 INFO - Installing distribute.............................................................................................................................................................................................done. 10:25:49 INFO - Installing pip.................done. 10:25:49 INFO - Return code: 0 10:25:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:25:50 INFO - Reading from file tmpfile_stdout 10:25:50 INFO - Output received: 10:25:50 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) 10:25:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:50 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:25:50 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 10:25:50 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 10:25:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:25:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:50 INFO - 'HOME': '/Users/cltbld', 10:25:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:50 INFO - 'LOGNAME': 'cltbld', 10:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:50 INFO - 'MOZ_NO_REMOTE': '1', 10:25:50 INFO - 'NO_EM_RESTART': '1', 10:25:50 INFO - 'PAGER': '/bin/cat', 10:25:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:50 INFO - 'PWD': '/builds/slave/test', 10:25:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:50 INFO - 'SHELL': '/bin/bash', 10:25:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:25:50 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:25:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:50 INFO - 'USER': 'cltbld', 10:25:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:50 INFO - 'XPC_FLAGS': '0x0', 10:25:50 INFO - 'XPC_SERVICE_NAME': '0', 10:25:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:50 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 10:25:50 INFO - Cleaning up... 10:25:50 INFO - Return code: 0 10:25:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:50 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:25:50 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 10:25:50 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 10:25:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:25:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:50 INFO - 'HOME': '/Users/cltbld', 10:25:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:50 INFO - 'LOGNAME': 'cltbld', 10:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:50 INFO - 'MOZ_NO_REMOTE': '1', 10:25:50 INFO - 'NO_EM_RESTART': '1', 10:25:50 INFO - 'PAGER': '/bin/cat', 10:25:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:50 INFO - 'PWD': '/builds/slave/test', 10:25:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:50 INFO - 'SHELL': '/bin/bash', 10:25:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:25:50 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:25:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:50 INFO - 'USER': 'cltbld', 10:25:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:50 INFO - 'XPC_FLAGS': '0x0', 10:25:50 INFO - 'XPC_SERVICE_NAME': '0', 10:25:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:50 INFO - Downloading/unpacking psutil>=3.1.1 10:25:50 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 10:25:50 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 10:25:50 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 10:25:50 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 10:25:50 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 10:25:50 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 10:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:25:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:54 INFO - Installing collected packages: psutil 10:25:54 INFO - Running setup.py install for psutil 10:25:54 INFO - building 'psutil._psutil_osx' extension 10:25:54 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 10:25:54 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 10:25:54 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 10:25:54 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 10:25:54 INFO - building 'psutil._psutil_posix' extension 10:25:54 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 10:25:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:25:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:25:54 INFO - ^ 10:25:54 INFO - 1 warning generated. 10:25:54 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 10:25:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:54 INFO - Successfully installed psutil 10:25:54 INFO - Cleaning up... 10:25:55 INFO - Return code: 0 10:25:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:55 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:25:55 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 10:25:55 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 10:25:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:25:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:55 INFO - 'HOME': '/Users/cltbld', 10:25:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:55 INFO - 'LOGNAME': 'cltbld', 10:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:55 INFO - 'MOZ_NO_REMOTE': '1', 10:25:55 INFO - 'NO_EM_RESTART': '1', 10:25:55 INFO - 'PAGER': '/bin/cat', 10:25:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:55 INFO - 'PWD': '/builds/slave/test', 10:25:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:55 INFO - 'SHELL': '/bin/bash', 10:25:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:25:55 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:25:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:55 INFO - 'USER': 'cltbld', 10:25:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:55 INFO - 'XPC_FLAGS': '0x0', 10:25:55 INFO - 'XPC_SERVICE_NAME': '0', 10:25:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:25:55 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 10:25:55 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 10:25:55 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 10:25:55 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 10:25:55 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 10:25:55 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 10:25:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:25:58 INFO - Installing collected packages: mozsystemmonitor 10:25:58 INFO - Running setup.py install for mozsystemmonitor 10:25:58 INFO - Successfully installed mozsystemmonitor 10:25:58 INFO - Cleaning up... 10:25:58 INFO - Return code: 0 10:25:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:58 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:25:58 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 10:25:58 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 10:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:58 INFO - 'HOME': '/Users/cltbld', 10:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:58 INFO - 'LOGNAME': 'cltbld', 10:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:58 INFO - 'MOZ_NO_REMOTE': '1', 10:25:58 INFO - 'NO_EM_RESTART': '1', 10:25:58 INFO - 'PAGER': '/bin/cat', 10:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:58 INFO - 'PWD': '/builds/slave/test', 10:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:58 INFO - 'SHELL': '/bin/bash', 10:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:25:58 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:58 INFO - 'USER': 'cltbld', 10:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:58 INFO - 'XPC_FLAGS': '0x0', 10:25:58 INFO - 'XPC_SERVICE_NAME': '0', 10:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:58 INFO - Downloading/unpacking jsonschema==2.5.1 10:25:58 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 10:25:58 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 10:25:58 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 10:25:58 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 10:25:58 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 10:25:58 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 10:26:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:26:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:26:01 INFO - warning: no files found matching '*.txt' 10:26:01 INFO - no previously-included directories found matching 'build' 10:26:01 INFO - no previously-included directories found matching 'dist' 10:26:01 INFO - no previously-included directories found matching '.git*' 10:26:01 INFO - Installing collected packages: jsonschema, functools32 10:26:01 INFO - Running setup.py install for functools32 10:26:01 INFO - warning: no files found matching '*.txt' 10:26:01 INFO - no previously-included directories found matching 'build' 10:26:01 INFO - no previously-included directories found matching 'dist' 10:26:01 INFO - no previously-included directories found matching '.git*' 10:26:01 INFO - Successfully installed jsonschema functools32 10:26:01 INFO - Cleaning up... 10:26:01 INFO - Return code: 0 10:26:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:26:01 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')]} 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:01 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')]} 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:01 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:26:01 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 10:26:01 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 10:26:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:01 INFO - 'HOME': '/Users/cltbld', 10:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:01 INFO - 'LOGNAME': 'cltbld', 10:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:01 INFO - 'MOZ_NO_REMOTE': '1', 10:26:01 INFO - 'NO_EM_RESTART': '1', 10:26:01 INFO - 'PAGER': '/bin/cat', 10:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:01 INFO - 'PWD': '/builds/slave/test', 10:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:01 INFO - 'SHELL': '/bin/bash', 10:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:26:01 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:01 INFO - 'USER': 'cltbld', 10:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:01 INFO - 'XPC_FLAGS': '0x0', 10:26:01 INFO - 'XPC_SERVICE_NAME': '0', 10:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:26:02 INFO - Cleaning up... 10:26:02 INFO - Return code: 0 10:26:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:02 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:26:02 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 10:26:02 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 10:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:02 INFO - 'HOME': '/Users/cltbld', 10:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:02 INFO - 'LOGNAME': 'cltbld', 10:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:02 INFO - 'MOZ_NO_REMOTE': '1', 10:26:02 INFO - 'NO_EM_RESTART': '1', 10:26:02 INFO - 'PAGER': '/bin/cat', 10:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:02 INFO - 'PWD': '/builds/slave/test', 10:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:02 INFO - 'SHELL': '/bin/bash', 10:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:26:02 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:02 INFO - 'USER': 'cltbld', 10:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:02 INFO - 'XPC_FLAGS': '0x0', 10:26:02 INFO - 'XPC_SERVICE_NAME': '0', 10:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:26:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:26:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:06 INFO - Downloading docopt-0.6.1.tar.gz 10:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:26:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:06 INFO - Running setup.py install for blobuploader 10:26:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:26:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:26:06 INFO - Running setup.py install for requests 10:26:06 INFO - Running setup.py install for docopt 10:26:07 INFO - Successfully installed blobuploader requests docopt 10:26:07 INFO - Cleaning up... 10:26:07 INFO - Return code: 0 10:26:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:07 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:26:07 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 10:26:07 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 10:26:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:26:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:07 INFO - 'HOME': '/Users/cltbld', 10:26:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:07 INFO - 'LOGNAME': 'cltbld', 10:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:07 INFO - 'MOZ_NO_REMOTE': '1', 10:26:07 INFO - 'NO_EM_RESTART': '1', 10:26:07 INFO - 'PAGER': '/bin/cat', 10:26:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:07 INFO - 'PWD': '/builds/slave/test', 10:26:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:07 INFO - 'SHELL': '/bin/bash', 10:26:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:26:07 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:26:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:07 INFO - 'USER': 'cltbld', 10:26:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:07 INFO - 'XPC_FLAGS': '0x0', 10:26:07 INFO - 'XPC_SERVICE_NAME': '0', 10:26:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:07 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-HyIGE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:07 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-M_ayF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:07 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-veMxqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:07 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hJxGEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:07 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-1HTMyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:07 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-frFmG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-PtVLAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-3TvVo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-YRRGoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-l14lBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-UyPhrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BlBZYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-vYUUpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Ku7Hrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-dS5P_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-DitraQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-8ZPDN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:09 INFO - Running setup.py install for manifestparser 10:26:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:26:09 INFO - Running setup.py install for mozcrash 10:26:09 INFO - Running setup.py install for mozdebug 10:26:09 INFO - Running setup.py install for mozdevice 10:26:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:26:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:26:09 INFO - Running setup.py install for mozfile 10:26:09 INFO - Running setup.py install for mozhttpd 10:26:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Running setup.py install for mozinfo 10:26:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Running setup.py install for mozInstall 10:26:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Running setup.py install for mozleak 10:26:10 INFO - Running setup.py install for mozlog 10:26:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Running setup.py install for moznetwork 10:26:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:26:10 INFO - Running setup.py install for mozprocess 10:26:10 INFO - Running setup.py install for mozprofile 10:26:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:26:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:26:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:26:11 INFO - Running setup.py install for mozrunner 10:26:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:26:11 INFO - Running setup.py install for mozscreenshot 10:26:11 INFO - Running setup.py install for moztest 10:26:11 INFO - Running setup.py install for mozversion 10:26:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:26:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:11 INFO - Cleaning up... 10:26:11 INFO - Return code: 0 10:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:11 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')]} 10:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 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')]} 10:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:26:11 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 10:26:11 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 10:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:11 INFO - 'HOME': '/Users/cltbld', 10:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:11 INFO - 'LOGNAME': 'cltbld', 10:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:11 INFO - 'MOZ_NO_REMOTE': '1', 10:26:11 INFO - 'NO_EM_RESTART': '1', 10:26:11 INFO - 'PAGER': '/bin/cat', 10:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:11 INFO - 'PWD': '/builds/slave/test', 10:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:11 INFO - 'SHELL': '/bin/bash', 10:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:26:11 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:11 INFO - 'USER': 'cltbld', 10:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:11 INFO - 'XPC_FLAGS': '0x0', 10:26:11 INFO - 'XPC_SERVICE_NAME': '0', 10:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-i9E7X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hhFO2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-ObU9Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-uw3SbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-a2XvDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-FtghXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-rnwJJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-WQC8Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:12 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)) 10:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-njRYak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-OmHqwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-UkgZFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-s8JlYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-wSTxYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-nOKJ8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hDd4vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-ANYLQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-oyRoK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:13 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)) 10:26:13 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)) 10:26:13 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)) 10:26:13 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)) 10:26:13 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)) 10:26:13 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)) 10:26:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:13 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 10:26:13 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 10:26:13 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 10:26:13 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 10:26:13 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 10:26:13 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 10:26:16 INFO - Downloading blessings-1.6.tar.gz 10:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:26:16 INFO - Installing collected packages: blessings 10:26:16 INFO - Running setup.py install for blessings 10:26:16 INFO - Successfully installed blessings 10:26:16 INFO - Cleaning up... 10:26:16 INFO - Return code: 0 10:26:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:17 INFO - Reading from file tmpfile_stdout 10:26:17 INFO - Current package versions: 10:26:17 INFO - blessings == 1.6 10:26:17 INFO - blobuploader == 1.2.4 10:26:17 INFO - docopt == 0.6.1 10:26:17 INFO - functools32 == 3.2.3-2 10:26:17 INFO - jsonschema == 2.5.1 10:26:17 INFO - manifestparser == 1.1 10:26:17 INFO - mozInstall == 1.12 10:26:17 INFO - mozcrash == 1.0 10:26:17 INFO - mozdebug == 0.1 10:26:17 INFO - mozdevice == 0.49 10:26:17 INFO - mozfile == 1.2 10:26:17 INFO - mozhttpd == 0.7 10:26:17 INFO - mozinfo == 0.9 10:26:17 INFO - mozleak == 0.1 10:26:17 INFO - mozlog == 3.4 10:26:17 INFO - moznetwork == 0.27 10:26:17 INFO - mozprocess == 0.24 10:26:17 INFO - mozprofile == 0.28 10:26:17 INFO - mozrunner == 6.13 10:26:17 INFO - mozscreenshot == 0.1 10:26:17 INFO - mozsystemmonitor == 0.3 10:26:17 INFO - moztest == 0.8 10:26:17 INFO - mozversion == 1.4 10:26:17 INFO - psutil == 3.1.1 10:26:17 INFO - requests == 1.2.3 10:26:17 INFO - wsgiref == 0.1.2 10:26:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:18 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:26:18 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 10:26:18 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 10:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:18 INFO - 'HOME': '/Users/cltbld', 10:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:18 INFO - 'LOGNAME': 'cltbld', 10:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:18 INFO - 'MOZ_NO_REMOTE': '1', 10:26:18 INFO - 'NO_EM_RESTART': '1', 10:26:18 INFO - 'PAGER': '/bin/cat', 10:26:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:18 INFO - 'PWD': '/builds/slave/test', 10:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:18 INFO - 'SHELL': '/bin/bash', 10:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:26:18 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:18 INFO - 'USER': 'cltbld', 10:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:18 INFO - 'XPC_FLAGS': '0x0', 10:26:18 INFO - 'XPC_SERVICE_NAME': '0', 10:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 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)) 10:26:18 INFO - Cleaning up... 10:26:18 INFO - Return code: 0 10:26:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:18 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 0x10b1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb9473250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, '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.0eQqOQNkzs/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.DtZObXscE9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 10:26:18 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 10:26:18 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 10:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:18 INFO - 'HOME': '/Users/cltbld', 10:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:18 INFO - 'LOGNAME': 'cltbld', 10:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:18 INFO - 'MOZ_NO_REMOTE': '1', 10:26:18 INFO - 'NO_EM_RESTART': '1', 10:26:18 INFO - 'PAGER': '/bin/cat', 10:26:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:18 INFO - 'PWD': '/builds/slave/test', 10:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:18 INFO - 'SHELL': '/bin/bash', 10:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:26:18 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:18 INFO - 'USER': 'cltbld', 10:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:18 INFO - 'XPC_FLAGS': '0x0', 10:26:18 INFO - 'XPC_SERVICE_NAME': '0', 10:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:26:19 INFO - Cleaning up... 10:26:19 INFO - Return code: 0 10:26:19 INFO - Running post-action listener: _resource_record_post_action 10:26:19 INFO - Running post-action listener: _start_resource_monitoring 10:26:19 INFO - Starting resource monitoring. 10:26:19 INFO - [mozharness: 2017-02-07 18:26:19.114554Z] Finished create-virtualenv step (success) 10:26:19 INFO - [mozharness: 2017-02-07 18:26:19.115531Z] Running install step. 10:26:19 INFO - Running pre-action listener: _resource_record_pre_action 10:26:19 INFO - Running main action method: install 10:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:19 INFO - Reading from file tmpfile_stdout 10:26:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:26:19 INFO - Reading from file tmpfile_stdout 10:26:19 INFO - Output received: 10:26:19 INFO - Usage: mozinstall [options] installer 10:26:19 INFO - Options: 10:26:19 INFO - -h, --help show this help message and exit 10:26:19 INFO - -d DEST, --destination=DEST 10:26:19 INFO - Directory to install application into. [default: 10:26:19 INFO - "/builds/slave/test"] 10:26:19 INFO - --app=APP Application being installed. [default: firefox] 10:26:19 INFO - mkdir: /builds/slave/test/build/application 10:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:26:39 INFO - Reading from file tmpfile_stdout 10:26:39 INFO - Output received: 10:26:39 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:26:39 INFO - Running post-action listener: _resource_record_post_action 10:26:39 INFO - [mozharness: 2017-02-07 18:26:39.396927Z] Finished install step (success) 10:26:39 INFO - [mozharness: 2017-02-07 18:26:39.397090Z] Running run-tests step. 10:26:39 INFO - Running pre-action listener: _resource_record_pre_action 10:26:39 INFO - Running main action method: run_tests 10:26:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:26:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:26:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:26:39 INFO - 2017-02-07 10:26:39.411 screenresolution[2494:30472] starting screenresolution argv=screenresolution get 10:26:39 INFO - 2017-02-07 10:26:39.414 screenresolution[2494:30472] Display 0: 1600x1200x32@60 10:26:39 INFO - 2017-02-07 10:26:39.420 screenresolution[2495:30474] starting screenresolution argv=screenresolution list 10:26:39 INFO - Available Modes on Display 0 10:26:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:26:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:26:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:26:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:26:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:26:39 INFO - Intel Iris: 10:26:39 INFO - Chipset Model: Intel Iris 10:26:39 INFO - Type: GPU 10:26:39 INFO - Bus: Built-In 10:26:39 INFO - VRAM (Dynamic, Max): 1536 MB 10:26:39 INFO - Vendor: Intel (0x8086) 10:26:39 INFO - Device ID: 0x0a2e 10:26:39 INFO - Revision ID: 0x0009 10:26:39 INFO - Displays: 10:26:39 INFO - Display: 10:26:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:26:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:26:39 INFO - Display Serial Number: 1600x1200 60 10:26:39 INFO - Main Display: Yes 10:26:39 INFO - Mirror: Off 10:26:39 INFO - Online: Yes 10:26:39 INFO - Rotation: Supported 10:26:39 INFO - Return code: 0 10:26:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:26:39 INFO - Python 2.7.3 10:26:39 INFO - Return code: 0 10:26:39 INFO - grabbing minidump binary from tooltool 10:26:39 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')]} 10:26:39 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 0x10af8bd30>, '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 0x10aeb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af80be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:26:39 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 10:26:39 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 10:26:39 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 10:26:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:26:39 INFO - Return code: 0 10:26:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:26:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:26:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:26:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:26:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:26:39 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/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 10:26:39 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/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --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 10:26:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eQqOQNkzs/Render', 10:26:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:39 INFO - 'HOME': '/Users/cltbld', 10:26:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:39 INFO - 'LOGNAME': 'cltbld', 10:26:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:26:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:39 INFO - 'MOZ_NO_REMOTE': '1', 10:26:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:26:39 INFO - 'NO_EM_RESTART': '1', 10:26:39 INFO - 'PAGER': '/bin/cat', 10:26:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:39 INFO - 'PWD': '/builds/slave/test', 10:26:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:26:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:39 INFO - 'SHELL': '/bin/bash', 10:26:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtZObXscE9/Listeners', 10:26:39 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:26:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:39 INFO - 'USER': 'cltbld', 10:26:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:39 INFO - 'XPC_FLAGS': '0x0', 10:26:39 INFO - 'XPC_SERVICE_NAME': '0', 10:26:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:39 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/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 10:26:39 INFO - mozversion application_buildid: 20170207083756 10:26:39 INFO - mozversion application_changeset: 514a5268030faf927430313a96a9e470e5c14c11 10:26:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:26:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:26:39 INFO - mozversion application_name: Firefox 10:26:39 INFO - mozversion application_remotingname: firefox-dev 10:26:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:26:40 INFO - mozversion application_vendor: Mozilla 10:26:40 INFO - mozversion application_version: 53.0a2 10:26:40 INFO - mozversion platform_buildid: 20170207083756 10:26:40 INFO - mozversion platform_changeset: 514a5268030faf927430313a96a9e470e5c14c11 10:26:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:26:40 INFO - mozversion platform_version: 53.0a2 10:26:40 INFO - using testdate: 1486491999 10:26:40 INFO - actual date: 1486491999 10:26:40 INFO - starting webserver on 'localhost:59882' 10:26:40 INFO - SUITE-START | Running 2 tests 10:26:40 INFO - TEST-START | dromaeo_css 10:26:40 INFO - operating with platform_type : mac_ 10:26:40 INFO - Initialising browser for dromaeo_css test... 10:26:40 INFO - TEST-INFO | started process 2505 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpkL2ilW/profile http://localhost:59882/getInfo.html) 10:26:42 INFO - PROCESS | 2505 | 2017-02-07 10:26:42.883 plugin-container[2507:30650] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484f, name = 'com.apple.tsm.portname' 10:26:42 INFO - PROCESS | 2505 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:42 INFO - PROCESS | 2505 | 2017-02-07 10:26:42.886 plugin-container[2507:30650] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4853, name = 'com.apple.CFPasteboardClient' 10:26:42 INFO - PROCESS | 2505 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:42 INFO - PROCESS | 2505 | 2017-02-07 10:26:42.886 plugin-container[2507:30650] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:26:42 INFO - PROCESS | 2505 | __metrics Screen width/height:1600/1200 10:26:42 INFO - PROCESS | 2505 | colorDepth:24 10:26:42 INFO - PROCESS | 2505 | Browser inner width/height: 1024/689 10:26:42 INFO - PROCESS | 2505 | __metrics 10:26:43 ERROR - PROCESS | 2505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 10:26:43 INFO - PROCESS | 2505 | 1486492003103 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpkL2ilW/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpkL2ilW/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpkL2ilW/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpkL2ilW/profile/extensions/talos-powers@TalosPowersService.js:55:9 10:26:43 INFO - TEST-INFO | 2505: exit 0 10:26:43 INFO - Browser initialized. 10:26:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:26:43 INFO - TEST-INFO | started process 2508 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpkL2ilW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:46 INFO - PROCESS | 2508 | 2017-02-07 10:26:46.158 plugin-container[2509:30778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 10:26:46 INFO - PROCESS | 2508 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:46 INFO - PROCESS | 2508 | 2017-02-07 10:26:46.159 plugin-container[2509:30778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:26:46 INFO - PROCESS | 2508 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:46 INFO - PROCESS | 2508 | 2017-02-07 10:26:46.159 plugin-container[2509:30778] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:26:55 INFO - PROCESS | 2508 | RSS: Main: 219123712 10:26:55 INFO - PROCESS | 2508 | 10:29:58 INFO - PROCESS | 2508 | Cycle 1(1): loaded http://localhost:59882/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59882/tests/dromaeo/cssquery-ext.html) 10:30:00 INFO - PROCESS | 2508 | RSS: Main: 239976448 10:30:00 INFO - PROCESS | 2508 | 10:31:44 INFO - PROCESS | 2508 | ************************* 10:31:44 INFO - PROCESS | 2508 | A coding exception was thrown and uncaught in a Task. 10:31:44 INFO - PROCESS | 2508 | 10:31:44 ERROR - PROCESS | 2508 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:31:44 INFO - PROCESS | 2508 | Full stack: 10:31:44 INFO - PROCESS | 2508 | ************************* 10:33:03 INFO - PROCESS | 2508 | Cycle 1(1): loaded http://localhost:59882/tests/dromaeo/cssquery-ext.html (next: http://localhost:59882/tests/dromaeo/cssquery-jquery.html) 10:33:03 INFO - PROCESS | 2508 | RSS: Main: 247926784 10:33:03 INFO - PROCESS | 2508 | 10:36:05 INFO - PROCESS | 2508 | Cycle 1(1): loaded http://localhost:59882/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59882/tests/dromaeo/cssquery-mootools.html) 10:36:06 INFO - PROCESS | 2508 | RSS: Main: 254328832 10:36:06 INFO - PROCESS | 2508 | 10:39:08 INFO - PROCESS | 2508 | Cycle 1(1): loaded http://localhost:59882/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59882/tests/dromaeo/cssquery-prototype.html) 10:39:08 INFO - PROCESS | 2508 | RSS: Main: 254382080 10:39:08 INFO - PROCESS | 2508 | 10:42:11 INFO - PROCESS | 2508 | Cycle 1(1): loaded http://localhost:59882/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59882/tests/dromaeo/cssquery-yui.html) 10:42:12 INFO - PROCESS | 2508 | RSS: Main: 258457600 10:42:12 INFO - PROCESS | 2508 | 10:45:14 INFO - PROCESS | 2508 | Cycle 1(1): loaded http://localhost:59882/tests/dromaeo/cssquery-yui.html (next: http://localhost:59882/tests/dromaeo/cssquery-dojo.html) 10:45:15 INFO - PROCESS | 2508 | RSS: Main: 259772416 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | __start_tp_report 10:45:15 INFO - PROCESS | 2508 | _x_x_mozilla_page_load 10:45:15 INFO - PROCESS | 2508 | _x_x_mozilla_page_load_details 10:45:15 INFO - PROCESS | 2508 | |i|pagename|runs| 10:45:15 INFO - PROCESS | 2508 | |0;dojo.html;3373.8650453981836;3389.322135572886;3397.2865698203377;3408.982955085226;3430.5711786026745;5847.502962248209;5887.85280367991;5889.8822023559505;5921.911171332428;5937.58436909416;5838.9124163137585;5852.063669812831;5861.8827623447505;5881;5884.176215329857;5266.262723218752;5325.653832500875;5337.359516857982;5368.70472124033;5406.459354064582;5364.034473794715;5364.222187782769;5380.0046991306535;5382.6232163748555;5443.265159203516;5301.840944771644;5307.708076055835;5363.007843548937;5365.195220716904;5372.91940620891;5310.973445132769;5323.095073837457;5361.651492652965;5422.15956526739;5439.646422982493;5239;5335.599830012726;5354.330708661418;5362.302900622894;5396.298481197419;5646.265985421869;5813.186153938452;5861.443162899561;5919.437653422961;5931.851703707399;5894.585299528126;6193.566450348478;6221.595596286227;6224.844378890519;6288.842778930518;5712.200291959129;6347.952587823003;6348.333424990402;6355.936440635581;6374.553781235315;4983.626228032912;5955.791547295824;6010.879782404371;6082.118092876508;6098.298695650013;5284.260203571426;6222.595531290452;6342.556021078481;6394.104825324458;6464.482841372679;5517.565432987452;5971.313298970587;6143.174139895608;6191.4118158774845;6296.590721603081;6300.3524044365795;6357.427831495188;6360.9045864312075;6372.745090196433;6378.808635740936;5640.32316122068;5799.072148456311;6218.19163508741;6236.937630623726;6294.370562943669;5162.767675454614;5531.197976293415;6044.607100538451;6232.439080482778;6308.211473565804;5146.30524879144;5152.4847515248175;5154.613403994716;5157.8452646420665;5196.402413722471;4431.512533621299;4496.887577810516;4558.111168322145;4561.931571026437;4586.3579098926175;5972.223610930551;5992.131140984533;6018.15745795589;6082.726277317532;6123.357047509948;6279.215098112736;6371.426571608577;6378.883695353387;6380.330065343165;6388.329225431263;5762.279715035621;5817.476427121579;5927.644341339534;5944.375840536768;5979.372165922602;5553.333599968029;5604.3835178130375;5623.184638227434;5623.297087864017;5639.887202255932;6501.2523559791225;6504.121943537656;6518.478521718251;6527.640979746159;6550.967245163743;6249.187605611241;6255.562110652393;6269.18500594938;6285.49716022708;6338.841528961812;6459.354064593691;6518.511111666549;6537.673116344069;6542.313057129123;6547.574407663486;6257.8748425030335;6283.434490895841;6312.905306420499;6320.810375688737;6343.9365606343345;5325;6143.262808463013;6202.255729312331;6238.6880655967925;6336.8098957029515;6204.565680402328;6248.4376406123665;6291.245050593958;6294.024426213944;6302.873942521215;6214.25428948529;6253.6560489173535;6275.02737075754;6276.372362763687;6326.240851097898;5972.70136493165;6032.788852390146;6051.848703782441;6112.847178820565;6184.381561843779;6158.568900176944;6164.260288765377;6203.906941395973;6255.78104766331;6264.937350626436;6153.538484613582;6159.076138579249;6176.135341052346;6185.752569897154;6192.0711893214575 10:45:15 INFO - PROCESS | 2508 | |1;ext.html;451.2103818317943;474.746010884177;488.7531796442798;498.990020199596;521.1531261699738;38559.22881542371;41394.58605413949;41472.37791433131;41569;41920.37119443211;42744.3588346175;43163.3525497117;43200.783996080056;43367;43417.13165736684;8467.66129354825;8691.435056721324;9269.119433653808;9507.477088760115;9533;11294.378809165493;11696.7660646787;11724.531018759239;11807.881921180808;11864.466099025522;11367.204295699305;11457.541698332057;11622.953934145926;11688.649340519798;11702.707432314175;11589.130815188895;11624.593139240085;11634.127440441916;11646.883531164665;11647.592334268345;9602;11463.36951467669;11515.884841151565;11521.48153333102;11579.36313502757;35421.40603672841;40083;41071.76784696464;41409.378859317134;41486.962825929295;3988.840446382141;4025.6175663311938;4118.073433477473;4126.360414135784;4197.853075142355;29992;30446.391072178652;30547.541786873215;31505.21236969071;32258.83870580632;3292.456744637132;3309.387763263804;3323.3187196624635;3390.0168951004425;3417.726581873444;440789;441026;446628;446923;447280;62786;63765.68117159477;64004.67997659982;64106.71786564243;64204.35795641984;67712;68113;68296.65851670809;68343.97484037743;68577.65711171413;16541.917290413472;16985.49043528696;16996.915015424845;17007;17354.39259625907;11074.335539867634;11220;12830.679233019062;12940;13113.409896554678;15668.68662626741;16163.545280924538;17656.470305890845;17673;17717.7342339865;5702.429757024264;7001.194862590765;7012.474064445187;7032.367086962198;7038.6480675965995;795.0538858758059;848.2535368875474;884.0805562215353;886.9512176830207;900.5857305639479;30333;30750.84624576863;30806;30995.0701478956;31107.844460777553;1061.2624226162898;1084.9891501085046;1109.290054365207;1114.1922106472744;1222.3826967381594;13663.111897726616;14658.340374683165;15506.379744810307;15900.363985440454;16551.751723724155;602046;602071;602273;602419;605523;54134.18798718022;54178.64553386197;54240.45759542433;54342.72828635832;54385.72807135939;1227.766724322376;1435.224978511592;1435.3397437179015;1449.340550049725;1462.7805829125716;28135.296617583906;28983.85508072446;29053.418931621673;29191.270218243862;29607.259818503848;46699.76650116728;46848.297275541576;46899.8275043113;47144.057118858116;47239.87420566014;528778;531809;532637.3368133134;533258;533904;22361.44096397603;23111.88444057769;24399.39001524976;25064;25214.369640759127;40306.596934031455;42733;42901.92745181396;43297.56702432936;43461.34807977946;35250.47124293189;35658.64341356657;35711.75008874677;35717.46423803593;35835;35464.936051918485;35491;35510;35709.64290357063;35795;23251.76748232564;29139.7086029137;34440.79457218985;34721;35169.648303517664;25911.352216194748;30680.232994175323;31970.6802931977;32110;32174.678253217167;23660.290191294287;23931.880340598185;24052.27843164708;24436.51126977486;24501 10:45:15 INFO - PROCESS | 2508 | |2;jquery.html;379.5614620587972;385.8572328238552;395.91092004299054;399.22948708991646;402;14253.572392828219;21649;22084.668729969024;22127.080467077598;22338.441538961513;18795.906020469913;19014.239430422767;21842.907854607245;22176.445588860246;22247.888760556216;5798.797042103527;5820.097884827848;5959.940400596003;6039.728212230439;6041.305249896274;3710.6289371062812;4400.361947517608;5891.351951285376;5992.910106348409;5998.760049598032;6316.115743795872;6590.604563726168;6645.700943457532;6685.231198412172;6709.261981182066;5500.42245564218;6502.992036234391;6629.370209830058;6658.434033107192;6671.833204169886;5799.507041901401;5834.154047663107;5837.036888913367;5842.912356314659;5867.530597552228;11112.722181945435;13657.521986730517;23151.495152815012;24476.877615611986;25341;2569.254916074336;2631.6447279617196;2682.248970288322;2696.5955106734145;2721.7958653101095;10021.59913603455;10095.646652367132;10316.123129533999;10752.193585481042;10789.83815242772;1797.757302764123;1821.6812057889815;1838.6690395728763;1906.494778883597;1913.818187272221;95753;125469;129189;130501;132139;11808.822867656992;11817;12134.089943254292;12135.211211271238;12148.696282593006;15835.524934251991;15887.364505419653;15940.20298985046;15940.92029539868;15958.521244362688;8863.468191908507;9006.684766033157;9051.094890511027;9064.274858011344;9102.499362535124;7170.498065135391;8751.168638979287;8792.956035219911;8827.16141966512;8939.418937769024;4307.030918043415;4463.509014008457;4859.392575928009;4865.197242455026;4921.655484116149;1498.273337431345;1690.4168062018584;2058.752949646052;2096.937091887246;2107.346722516025;1016.1201776713021;1048.3343077146067;1055.6832950114936;1073.897979691928;1075.6504136155625;21678.45803854916;22013;22078.33764987053;22099.668504972116;22111.44721381946;1046.7906418716286;1089.8310761831929;1092.4428541443922;1093.1309608860975;1104.436737264001;9557.23542116629;10984.835227471434;11319.377434241196;11436.085113190924;12363.381830908418;797018;797082;799658;809906;811357;112245;128951;165992;166090;167221;890.3411475508077;912.8767616371838;1059.4596755654673;1082.9603580562748;1088.1784252889177;15205.315760791013;16813.747793783346;16819.24313405924;16914.492565223063;17744.46766597004;46748.7662561685;48534;53729.38811835651;54124.45875541194;61419;84247.5787621058;87355;87594;88469;89306.10693892978;8163.755087347389;8370.455920365157;8502.78743031429;8554;8637.006744224494;12231.816522752344;12630.368481576068;13333.799992999919;13356.731110544482;13793.310334483034;9023.819523609622;9118;9408.388454750419;10737.604111465773;11618.012468940235;9088;10314.123299519324;11160.720981975515;11295.943520282346;11418.771624567627;11580.36308003068;11643.417829108681;11822.054235660955;11879.643610691694;11959.461824217757;7331.74338898136;8334.791455239078;8348.998120225611;8354.916450835413;8700.651973921225;9499.715008549754;11228.101751859995;11322.490487927898;11576.768464630828;11660.53357865676 10:45:15 INFO - PROCESS | 2508 | |3;mootools.html;1289.6517940156157;1428.8213973253337;1439.8920080993928;1447.6091455307067;1466.4427517543336;7491.737789177379;7747.070351557807;8066.233707797757;8508.276796472308;8527.23254907059;7567.826986817038;7612.885806712904;8354.874676879837;8435.62039708213;8463.788405289872;2279.931602051937;2322.4658328584437;2329.184785325131;2331.067572970817;2339.0526836631193;2069.665066032408;2308.9307320780404;2346.23747282134;2366.2782851230368;2370.7392186859433;2062.7730949595534;2245.371296037112;2319.153508969231;2325.883705814711;2333.265021518225;2278.737945136314;2292.5758734634064;2296.047140436725;2302.9866858582172;2305.561943230781;2283.7602051784656;2319.988400057989;2346.5424242272766;2350.4358953851124;2351.564960482316;8321.95839020801;8423.789405264855;8424.578771061422;8429.789255268606;8450.535220562866;5064.063148317573;5199.064168449678;5210.76551555181;5212.947870521322;5214.582833373321;2985.776066794999;3508.5088087667746;3560.946585801215;3612.205314830733;3632.3824949758605;1050.8528805967171;1218.8537375514995;1244.8879600835878;1260.8526241120537;1274.1399555300136;8419.494830310201;10730.302530335503;10789.082927951134;10827.296225745302;10886.183536234814;4445.644348452116;4700.858974230779;4712.811487540528;4767.475577686451;4788;9428.38715483505;9526.90473095274;9531.904680953241;9540;9547.33168678186;5223.608229382811;5270.631055826056;5282.603804714585;5285.445028272053;5286.656367336188;4561.498235194126;4582.908341833145;4751.738654374042;4847.442544107473;4854.101991131652;3885.786281754474;3901.6878649707955;3926.6662333701383;3977.482927219443;3986.6412022918075;1182.603827717707;1232.0944106082022;1284.0882973089024;1287.819705241267;1299.1685321394316;763.9312461878458;788.7436583110398;803.7709252862905;821.3059964330131;853.8292341531718;5447.591430642718;5543.251661025791;5649.915251271234;5661.971690141523;5670.319561652628;987.1707765477033;1018.0735530667057;1024.3444195714749;1030.4641586375044;1054.947252637365;3750.099976005739;3794.3739283017994;3842.558105817867;3858.6527212551005;3910.530736311604;9487.193588545051;9876.60493580263;9902.405855648683;10016.499175041365;10166.390016599027;8689.869651955225;9414.764630884145;9849.704508864745;9862.802743945082;9869.802603948025;7702.576358300235;7890.684372625031;7904.802379940547;7921.485103468256;7921.76234712948;4403.229434848825;5454.836354909359;5505.697186654612;5805.448482394166;5887.234659494238;8566;8962.462252264884;9065.41074830134;9142.451452912846;9356.391834530734;9219.44683319003;9359.391639543408;9369.578368973276;9393.765155871159;9416.670416535388;7218.530795498275;7290.781276561712;7315.707371705073;7341.265873412616;7354.558726476428;7714.922850771645;7917.683292668229;7948.761537153895;8015.959920200362;8045.5172689636465;7106.040684507525;7110.182329032021;7140.892886606809;7156.320149585781;7253.963730181315;6924.4114250287275;6983.860322793617;6984.930150698631;6997.965010174917;7012.789616311519;6329.90505142414;6349.428551430208;6358.777442789666;6416.165898433173;6426.710798014007;4815.422149342101;4832.95167048339;4867.878303042452;4896.094222568836;4911.484294149206;4961.7519124044375;4982;4988.251762235694;5016.272640467185;5023 10:45:15 INFO - PROCESS | 2508 | |4;prototype.html;313.788775327237;324.97400207983355;338.6765638814932;350.4340490108474;363.95086663300447;5239.345081864767;5349.839504814861;5381.327334083239;5476.58925580582;5649.107548971089;5012.423571289303;5019.021290848286;5224.320838291017;5326;5408.864778380543;3721.683656889154;4226.302660061094;4293.205756934962;4335.718178318415;4349;3343.665633436661;4091.6112969267874;4325.329573916048;4331.4802223733195;4373.890652733691;4202.621764041236;4205.095904380558;4226.492820861486;4226.873193804191;4274.0597068645;3766.058485378669;3878.6230888034906;4226.9154616907645;4288.16380805743;4319.719218250803;3786.6109831700473;3798.5631652360057;3801.505804245458;3816.580176180618;3823.1780167264174;4341.656924168373;5174.2238664200295;5227.830450363094;5244.085908643356;5297.735113244323;4181.916361672749;4329.480462344507;4920.40955085392;4959.429665588431;4983.950160498421;4624.791884365211;5768.336641286264;5808.954388210121;5830.15462757902;5830.416958304136;3701.61133081028;3726.3478891194204;4070.735402198877;4185.97907010463;4209.326507758744;6088.4215999479975;6090.26916769986;6102.96948515259;6142.819299148827;6181.505479561624;4116.732412393245;4241.1941731071;4242.427272318259;4252.723572967747;4295.806688699016;4222.577742225814;4310.698251122391;4315.546867578922;4343;4357.738535687806;4295.312749959991;4561.589456948891;4950.108980383566;4960.578350840219;4998.325226094431;5022.618779835501;5392.67879369557;5829.4170582942215;5832.300123985064;5877.735501902424;1209.3046498263534;1326.1777697827408;1393.0805668259104;1394.1008049807817;1408.7323408552547;943.528235882059;949.3544389814992;954.6372378496266;975.5853762151199;976.306822156277;4344.523621535757;4566.109608626286;4931.9753401232765;5101.372793011602;5114.43741188469;5343.225232341289;5466.808661696901;5708.74601477154;5714.828555143353;5749.080147176432;4384.702991068771;4579.885502862455;4715.39272456571;5202.687838729613;5220.843374698765;2715.3618899558983;2986.5664481049216;3002.6187953541616;3016.2760937374874;3034.4689679306034;5023.321851550067;5283.656562323436;5825.300963884361;5869.794557190563;5964.508872781805;5237.16205407133;5350.652207606493;5571.832845014656;5701.657900525982;5840.59115861894;5796.42035796417;5841.795537156179;5859.853503662443;5861.003629383101;5873.4435374625755;4922.572453988303;5360.855657736781;5366.175500329907;5476.863078423071;5735.483806457439;4901.485344038967;4927.359443272495;5591;5651.745671444877;5656.971715141398;5023.2214006829;5857.619254748428;5862.325832529314;5870.354261031369;5890.823275301748;3233.6766323367474;3708.406654935305;3734.402495600691;3757.8162878693124;4002.579729128516;4776.761161941959;4776.785044672929;5629.774809007594;5632.957902787997;5643.754840966542;4948.826791062295;5550.722463876871;5568.691357531058;5715.428457154251;5810.418958104325;5022.472640372708;5596.720163991866;5700.458456446631;5730.312362516358;5769.913451298318;5326.682892941582;5621.690807005654;5631.436856314336;5640.971795140998;5675.716214189357;4725.840351866856;4917.360743103373;5421.457854214547;5834.27071616048;5870.096385903326;4886.511348865085;5713.514351280021;5715.314162300384;5779.306483222041;5781 10:45:15 INFO - PROCESS | 2508 | |5;yui.html;710.2755189706496;720.3444865172687;759.3431681595422;814.9755507334779;840.4537050916904;14278.643033924143;14306.713865722679;14721.190334531597;14761.630959226011;14882.479113231038;14509.92745036276;14706.55880323592;14712.632184195401;14718.705625887476;15887;865.0311650950944;872.4852337121097;891.9821603567925;892.0633334998258;893.2719833335843;879.8680197970324;885.8759773631697;890.2566357091836;890.4746199742151;891.8751374807532;926.5876684875233;931;934.6495064350869;938.8779458670364;943.2831048403194;911.6717981526646;919.9586018629144;921.8018126102886;923.1230331185367;923.3674932671141;687;691.312144416309;691.5297597633607;692.9882371737269;694.2086021934998;15457.5362739118;15833.920830395775;15847.841521584753;15894.602634934103;15926.522204333773;14136.434542618283;14142;14226.14643121416;14276.857231427657;14282.785758213635;11670.35813030283;11856.288622682667;11876.524939002516;11880.940595296968;11905.583304584297;3675.320065787811;3677;3689.714993804213;3689.815509224528;3758.586555478895;102269;102990;103674.48162759213;115196;118113;11133.554657813758;11161.72781241455;11227;11461.598844040418;11861.644150675493;22150.778492215195;22317.553648927256;22503.324900253017;22694.97872595737;22971.770282297297;7846.843063138819;7857;8003.559804210708;8046.839063218703;8242.835143297101;4164.895877603084;4177.143685544456;4222.373704453766;4296.2266791977745;4335.1329734053315;3503.3518799022263;3569.607343192247;3587.9282414352087;3599.5320608321276;3706.369917114097;572.9828105156852;675.5946432140677;686.6703982088626;695.0929037605872;696.0186137546036;656.5174596671443;669.2544505420918;678.6911955060435;696.2967402923084;728.7667946257146;9521.143097121292;10324.118873514793;10414.635487757892;11113.277636953571;11491;594.2007999241014;597.7698586044318;600.9819705408757;614.50839328537;720.9783706488814;4482.013956929471;4704.744141511382;4791.305260737243;4861.683990540603;5143.074246635641;91163.08836911678;94847;95918;96347.51826240824;96751.51624241975;62067.689661551405;68694.65652671705;74782.8782568251;83061;84469;59507;76498;77094;77467;77643.61178194186;9845.212383009199;9968.55141518619;9977.251706121924;9981.650642227487;9995.600175992879;49419;49470;49554.504454954986;49809.256676016164;50979;62957.370426296984;63750;70975;71517.28482715314;73748;13202.801957970447;13265.270410127536;13430.462781488632;13451.548451548451;13551;14535.927320363331;14586.416543338148;14636.487722929647;14945.476908308157;15055.54833355001;13142.73714525685;13269.270190139636;13550.457981680622;14344.784828227794;14570.781438278646;13403.463861445824;13509.864901351253;13689.452421903012;14268.643283917985;14430.42278308856;13058.738825223252;13393.732125357634;13706.451741930212;14317.284135792961;14412.919031072921;10852.728681782703;11465.426728663366;11488.48301826403;11523.947894301094;11960.923516883522;10043.899561004297;10502.317349372266;10573.312734672221;11276.887231127585;11582.826257605973 10:45:15 INFO - PROCESS | 2508 | __end_tp_report 10:45:15 INFO - PROCESS | 2508 | __start_cc_report 10:45:15 INFO - PROCESS | 2508 | _x_x_mozilla_cycle_collect,375 10:45:15 INFO - PROCESS | 2508 | __end_cc_report 10:45:15 INFO - PROCESS | 2508 | __startTimestamp1486493115105__endTimestamp 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | ------- Summary: start ------- 10:45:15 INFO - PROCESS | 2508 | Number of tests: 6 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | [#0] dojo.html Cycles:165 Average:5837.94 Median:6032.79 stddev:639.05 (10.6%) stddev-sans-first:611.07 10:45:15 INFO - PROCESS | 2508 | Values: 3373.9 3389.3 3397.3 3409.0 3430.6 5847.5 5887.9 5889.9 5921.9 5937.6 5838.9 5852.1 5861.9 5881.0 5884.2 5266.3 5325.7 5337.4 5368.7 5406.5 5364.0 5364.2 5380.0 5382.6 5443.3 5301.8 5307.7 5363.0 5365.2 5372.9 5311.0 5323.1 5361.7 5422.2 5439.6 5239.0 5335.6 5354.3 5362.3 5396.3 5646.3 5813.2 5861.4 5919.4 5931.9 5894.6 6193.6 6221.6 6224.8 6288.8 5712.2 6348.0 6348.3 6355.9 6374.6 4983.6 5955.8 6010.9 6082.1 6098.3 5284.3 6222.6 6342.6 6394.1 6464.5 5517.6 5971.3 6143.2 6191.4 6296.6 6300.4 6357.4 6360.9 6372.7 6378.8 5640.3 5799.1 6218.2 6236.9 6294.4 5162.8 5531.2 6044.6 6232.4 6308.2 5146.3 5152.5 5154.6 5157.8 5196.4 4431.5 4496.9 4558.1 4561.9 4586.4 5972.2 5992.1 6018.2 6082.7 6123.4 6279.2 6371.4 6378.9 6380.3 6388.3 5762.3 5817.5 5927.6 5944.4 5979.4 5553.3 5604.4 5623.2 5623.3 5639.9 6501.3 6504.1 6518.5 6527.6 6551.0 6249.2 6255.6 6269.2 6285.5 6338.8 6459.4 6518.5 6537.7 6542.3 6547.6 6257.9 6283.4 6312.9 6320.8 6343.9 5325.0 6143.3 6202.3 6238.7 6336.8 6204.6 6248.4 6291.2 6294.0 6302.9 6214.3 6253.7 6275.0 6276.4 6326.2 5972.7 6032.8 6051.8 6112.8 6184.4 6158.6 6164.3 6203.9 6255.8 6264.9 6153.5 6159.1 6176.1 6185.8 6192.1 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | [#1] ext.html Cycles:180 Average:66275.57 Median:35443.17 stddev:141511.24 (399.3%) stddev-sans-first:141821.92 10:45:15 INFO - PROCESS | 2508 | Values: 451.2 474.7 488.8 499.0 521.2 38559.2 41394.6 41472.4 41569.0 41920.4 42744.4 43163.4 43200.8 43367.0 43417.1 8467.7 8691.4 9269.1 9507.5 9533.0 11294.4 11696.8 11724.5 11807.9 11864.5 11367.2 11457.5 11623.0 11688.6 11702.7 11589.1 11624.6 11634.1 11646.9 11647.6 9602.0 11463.4 11515.9 11521.5 11579.4 35421.4 40083.0 41071.8 41409.4 41487.0 3988.8 4025.6 4118.1 4126.4 4197.9 29992.0 30446.4 30547.5 31505.2 32258.8 3292.5 3309.4 3323.3 3390.0 3417.7 440789.0 441026.0 446628.0 446923.0 447280.0 62786.0 63765.7 64004.7 64106.7 64204.4 67712.0 68113.0 68296.7 68344.0 68577.7 16541.9 16985.5 16996.9 17007.0 17354.4 11074.3 11220.0 12830.7 12940.0 13113.4 15668.7 16163.5 17656.5 17673.0 17717.7 5702.4 7001.2 7012.5 7032.4 7038.6 795.1 848.3 884.1 887.0 900.6 30333.0 30750.8 30806.0 30995.1 31107.8 1061.3 1085.0 1109.3 1114.2 1222.4 13663.1 14658.3 15506.4 15900.4 16551.8 602046.0 602071.0 602273.0 602419.0 605523.0 54134.2 54178.6 54240.5 54342.7 54385.7 1227.8 1435.2 1435.3 1449.3 1462.8 28135.3 28983.9 29053.4 29191.3 29607.3 46699.8 46848.3 46899.8 47144.1 47239.9 528778.0 531809.0 532637.3 533258.0 533904.0 22361.4 23111.9 24399.4 25064.0 25214.4 40306.6 42733.0 42901.9 43297.6 43461.3 35250.5 35658.6 35711.8 35717.5 35835.0 35464.9 35491.0 35510.0 35709.6 35795.0 23251.8 29139.7 34440.8 34721.0 35169.6 25911.4 30680.2 31970.7 32110.0 32174.7 23660.3 23931.9 24052.3 24436.5 24501.0 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | [#2] jquery.html Cycles:180 Average:41619.70 Median:22212.17 stddev:133128.04 (599.3%) stddev-sans-first:133465.48 10:45:15 INFO - PROCESS | 2508 | Values: 379.6 385.9 395.9 399.2 402.0 14253.6 21649.0 22084.7 22127.1 22338.4 18795.9 19014.2 21842.9 22176.4 22247.9 5798.8 5820.1 5959.9 6039.7 6041.3 3710.6 4400.4 5891.4 5992.9 5998.8 6316.1 6590.6 6645.7 6685.2 6709.3 5500.4 6503.0 6629.4 6658.4 6671.8 5799.5 5834.2 5837.0 5842.9 5867.5 11112.7 13657.5 23151.5 24476.9 25341.0 2569.3 2631.6 2682.2 2696.6 2721.8 10021.6 10095.6 10316.1 10752.2 10789.8 1797.8 1821.7 1838.7 1906.5 1913.8 95753.0 125469.0 129189.0 130501.0 132139.0 11808.8 11817.0 12134.1 12135.2 12148.7 15835.5 15887.4 15940.2 15940.9 15958.5 8863.5 9006.7 9051.1 9064.3 9102.5 7170.5 8751.2 8793.0 8827.2 8939.4 4307.0 4463.5 4859.4 4865.2 4921.7 1498.3 1690.4 2058.8 2096.9 2107.3 1016.1 1048.3 1055.7 1073.9 1075.7 21678.5 22013.0 22078.3 22099.7 22111.4 1046.8 1089.8 1092.4 1093.1 1104.4 9557.2 10984.8 11319.4 11436.1 12363.4 797018.0 797082.0 799658.0 809906.0 811357.0 112245.0 128951.0 165992.0 166090.0 167221.0 890.3 912.9 1059.5 1083.0 1088.2 15205.3 16813.7 16819.2 16914.5 17744.5 46748.8 48534.0 53729.4 54124.5 61419.0 84247.6 87355.0 87594.0 88469.0 89306.1 8163.8 8370.5 8502.8 8554.0 8637.0 12231.8 12630.4 13333.8 13356.7 13793.3 9023.8 9118.0 9408.4 10737.6 11618.0 9088.0 10314.1 11160.7 11295.9 11418.8 11580.4 11643.4 11822.1 11879.6 11959.5 7331.7 8334.8 8349.0 8354.9 8700.7 9499.7 11228.1 11322.5 11576.8 11660.5 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | [#3] mootools.html Cycles:180 Average:5415.85 Median:5219.10 stddev:2914.73 (55.8%) stddev-sans-first:2906.41 10:45:15 INFO - PROCESS | 2508 | Values: 1289.7 1428.8 1439.9 1447.6 1466.4 7491.7 7747.1 8066.2 8508.3 8527.2 7567.8 7612.9 8354.9 8435.6 8463.8 2279.9 2322.5 2329.2 2331.1 2339.1 2069.7 2308.9 2346.2 2366.3 2370.7 2062.8 2245.4 2319.2 2325.9 2333.3 2278.7 2292.6 2296.0 2303.0 2305.6 2283.8 2320.0 2346.5 2350.4 2351.6 8322.0 8423.8 8424.6 8429.8 8450.5 5064.1 5199.1 5210.8 5212.9 5214.6 2985.8 3508.5 3560.9 3612.2 3632.4 1050.9 1218.9 1244.9 1260.9 1274.1 8419.5 10730.3 10789.1 10827.3 10886.2 4445.6 4700.9 4712.8 4767.5 4788.0 9428.4 9526.9 9531.9 9540.0 9547.3 5223.6 5270.6 5282.6 5285.4 5286.7 4561.5 4582.9 4751.7 4847.4 4854.1 3885.8 3901.7 3926.7 3977.5 3986.6 1182.6 1232.1 1284.1 1287.8 1299.2 763.9 788.7 803.8 821.3 853.8 5447.6 5543.3 5649.9 5662.0 5670.3 987.2 1018.1 1024.3 1030.5 1054.9 3750.1 3794.4 3842.6 3858.7 3910.5 9487.2 9876.6 9902.4 10016.5 10166.4 8689.9 9414.8 9849.7 9862.8 9869.8 7702.6 7890.7 7904.8 7921.5 7921.8 4403.2 5454.8 5505.7 5805.4 5887.2 8566.0 8962.5 9065.4 9142.5 9356.4 9219.4 9359.4 9369.6 9393.8 9416.7 7218.5 7290.8 7315.7 7341.3 7354.6 7714.9 7917.7 7948.8 8016.0 8045.5 7106.0 7110.2 7140.9 7156.3 7254.0 6924.4 6983.9 6984.9 6998.0 7012.8 6329.9 6349.4 6358.8 6416.2 6426.7 4815.4 4833.0 4867.9 4896.1 4911.5 4961.8 4982.0 4988.3 5016.3 5023.0 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | [#4] prototype.html Cycles:180 Average:4614.07 Median:5022.92 stddev:1370.60 (27.3%) stddev-sans-first:1335.90 10:45:15 INFO - PROCESS | 2508 | Values: 313.8 325.0 338.7 350.4 364.0 5239.3 5349.8 5381.3 5476.6 5649.1 5012.4 5019.0 5224.3 5326.0 5408.9 3721.7 4226.3 4293.2 4335.7 4349.0 3343.7 4091.6 4325.3 4331.5 4373.9 4202.6 4205.1 4226.5 4226.9 4274.1 3766.1 3878.6 4226.9 4288.2 4319.7 3786.6 3798.6 3801.5 3816.6 3823.2 4341.7 5174.2 5227.8 5244.1 5297.7 4181.9 4329.5 4920.4 4959.4 4984.0 4624.8 5768.3 5809.0 5830.2 5830.4 3701.6 3726.3 4070.7 4186.0 4209.3 6088.4 6090.3 6103.0 6142.8 6181.5 4116.7 4241.2 4242.4 4252.7 4295.8 4222.6 4310.7 4315.5 4343.0 4357.7 4295.3 4561.6 4950.1 4960.6 4998.3 5022.6 5392.7 5829.4 5832.3 5877.7 1209.3 1326.2 1393.1 1394.1 1408.7 943.5 949.4 954.6 975.6 976.3 4344.5 4566.1 4932.0 5101.4 5114.4 5343.2 5466.8 5708.7 5714.8 5749.1 4384.7 4579.9 4715.4 5202.7 5220.8 2715.4 2986.6 3002.6 3016.3 3034.5 5023.3 5283.7 5825.3 5869.8 5964.5 5237.2 5350.7 5571.8 5701.7 5840.6 5796.4 5841.8 5859.9 5861.0 5873.4 4922.6 5360.9 5366.2 5476.9 5735.5 4901.5 4927.4 5591.0 5651.7 5657.0 5023.2 5857.6 5862.3 5870.4 5890.8 3233.7 3708.4 3734.4 3757.8 4002.6 4776.8 4776.8 5629.8 5633.0 5643.8 4948.8 5550.7 5568.7 5715.4 5810.4 5022.5 5596.7 5700.5 5730.3 5769.9 5326.7 5621.7 5631.4 5641.0 5675.7 4725.8 4917.4 5421.5 5834.3 5870.1 4886.5 5713.5 5715.3 5779.3 5781.0 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - PROCESS | 2508 | [#5] yui.html Cycles:180 Average:19974.99 Median:4199.76 stddev:27978.78 (666.2%) stddev-sans-first:28019.87 10:45:15 INFO - PROCESS | 2508 | Values: 710.3 720.3 759.3 815.0 840.5 14278.6 14306.7 14721.2 14761.6 14882.5 14509.9 14706.6 14712.6 14718.7 15887.0 865.0 872.5 892.0 892.1 893.3 879.9 885.9 890.3 890.5 891.9 926.6 931.0 934.6 938.9 943.3 911.7 920.0 921.8 923.1 923.4 687.0 691.3 691.5 693.0 694.2 15457.5 15833.9 15847.8 15894.6 15926.5 14136.4 14142.0 14226.1 14276.9 14282.8 11670.4 11856.3 11876.5 11880.9 11905.6 3675.3 3677.0 3689.7 3689.8 3758.6 102269.0 102990.0 103674.5 115196.0 118113.0 11133.6 11161.7 11227.0 11461.6 11861.6 22150.8 22317.6 22503.3 22695.0 22971.8 7846.8 7857.0 8003.6 8046.8 8242.8 4164.9 4177.1 4222.4 4296.2 4335.1 3503.4 3569.6 3587.9 3599.5 3706.4 573.0 675.6 686.7 695.1 696.0 656.5 669.3 678.7 696.3 728.8 9521.1 10324.1 10414.6 11113.3 11491.0 594.2 597.8 601.0 614.5 721.0 4482.0 4704.7 4791.3 4861.7 5143.1 91163.1 94847.0 95918.0 96347.5 96751.5 62067.7 68694.7 74782.9 83061.0 84469.0 59507.0 76498.0 77094.0 77467.0 77643.6 9845.2 9968.6 9977.3 9981.7 9995.6 49419.0 49470.0 49554.5 49809.3 50979.0 62957.4 63750.0 70975.0 71517.3 73748.0 13202.8 13265.3 13430.5 13451.5 13551.0 14535.9 14586.4 14636.5 14945.5 15055.5 13142.7 13269.3 13550.5 14344.8 14570.8 13403.5 13509.9 13689.5 14268.6 14430.4 13058.7 13393.7 13706.5 14317.3 14412.9 10852.7 11465.4 11488.5 11523.9 11960.9 10043.9 10502.3 10573.3 11276.9 11582.8 10:45:15 INFO - PROCESS | 2508 | -------- Summary: end -------- 10:45:15 INFO - PROCESS | 2508 | 10:45:15 INFO - TEST-INFO | 2508: exit 0 10:45:15 INFO - TEST-OK | dromaeo_css | took 1115767ms 10:45:15 INFO - TEST-START | kraken 10:45:15 INFO - operating with platform_type : mac_ 10:45:15 INFO - Initialising browser for kraken test... 10:45:15 INFO - TEST-INFO | started process 2513 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpm0yb9R/profile http://localhost:59882/getInfo.html) 10:45:18 INFO - PROCESS | 2513 | 2017-02-07 10:45:18.621 plugin-container[2514:32631] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8837, name = 'com.apple.tsm.portname' 10:45:18 INFO - PROCESS | 2513 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:18 INFO - PROCESS | 2513 | 2017-02-07 10:45:18.624 plugin-container[2514:32631] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 10:45:18 INFO - PROCESS | 2513 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:18 INFO - PROCESS | 2513 | 2017-02-07 10:45:18.624 plugin-container[2514:32631] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:45:18 INFO - PROCESS | 2513 | __metrics Screen width/height:1600/1200 10:45:18 INFO - PROCESS | 2513 | colorDepth:24 10:45:18 INFO - PROCESS | 2513 | Browser inner width/height: 1024/689 10:45:18 INFO - PROCESS | 2513 | __metrics 10:45:18 ERROR - PROCESS | 2513 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 10:45:18 INFO - PROCESS | 2513 | 1486493118776 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpm0yb9R/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpm0yb9R/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpm0yb9R/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpm0yb9R/profile/extensions/talos-powers@TalosPowersService.js:55:9 10:45:19 INFO - TEST-INFO | 2513: exit 0 10:45:19 INFO - Browser initialized. 10:45:19 INFO - Running cycle 1/1 for kraken test... 10:45:19 INFO - TEST-INFO | started process 2515 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpm0yb9R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:21 INFO - PROCESS | 2515 | 2017-02-07 10:45:21.946 plugin-container[2516:32756] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 10:45:21 INFO - PROCESS | 2515 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:21 INFO - PROCESS | 2515 | 2017-02-07 10:45:21.947 plugin-container[2516:32756] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 10:45:21 INFO - PROCESS | 2515 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:21 INFO - PROCESS | 2515 | 2017-02-07 10:45:21.947 plugin-container[2516:32756] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:45:31 INFO - PROCESS | 2515 | RSS: Main: 218923008 10:45:31 INFO - PROCESS | 2515 | 10:45:34 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59882/tests/kraken/driver.html?testName=audio-beat-detection) 10:45:35 INFO - PROCESS | 2515 | RSS: Main: 233283584 10:45:35 INFO - PROCESS | 2515 | 10:45:37 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59882/tests/kraken/driver.html?testName=audio-dft) 10:45:38 INFO - PROCESS | 2515 | RSS: Main: 241111040 10:45:38 INFO - PROCESS | 2515 | 10:45:41 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59882/tests/kraken/driver.html?testName=audio-fft) 10:45:42 INFO - PROCESS | 2515 | RSS: Main: 244887552 10:45:42 INFO - PROCESS | 2515 | 10:45:44 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59882/tests/kraken/driver.html?testName=audio-oscillator) 10:45:45 INFO - PROCESS | 2515 | RSS: Main: 245182464 10:45:45 INFO - PROCESS | 2515 | 10:45:47 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59882/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:45:48 INFO - PROCESS | 2515 | RSS: Main: 245080064 10:45:48 INFO - PROCESS | 2515 | 10:45:50 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59882/tests/kraken/driver.html?testName=imaging-darkroom) 10:45:51 INFO - PROCESS | 2515 | RSS: Main: 249479168 10:45:51 INFO - PROCESS | 2515 | 10:45:54 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59882/tests/kraken/driver.html?testName=imaging-desaturate) 10:45:55 INFO - PROCESS | 2515 | RSS: Main: 248340480 10:45:55 INFO - PROCESS | 2515 | 10:45:58 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59882/tests/kraken/driver.html?testName=json-parse-financial) 10:45:58 INFO - PROCESS | 2515 | RSS: Main: 249970688 10:45:58 INFO - PROCESS | 2515 | 10:46:00 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59882/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:46:01 INFO - PROCESS | 2515 | RSS: Main: 249311232 10:46:01 INFO - PROCESS | 2515 | 10:46:03 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:46:03 INFO - PROCESS | 2515 | RSS: Main: 249266176 10:46:03 INFO - PROCESS | 2515 | 10:46:06 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:46:06 INFO - PROCESS | 2515 | RSS: Main: 249348096 10:46:06 INFO - PROCESS | 2515 | 10:46:09 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:46:10 INFO - PROCESS | 2515 | RSS: Main: 249765888 10:46:10 INFO - PROCESS | 2515 | 10:46:13 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:46:14 INFO - PROCESS | 2515 | RSS: Main: 249548800 10:46:14 INFO - PROCESS | 2515 | 10:46:15 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:59882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59882/tests/kraken/driver.html?testName=ai-astar) 10:46:16 INFO - PROCESS | 2515 | RSS: Main: 251326464 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | __start_tp_report 10:46:16 INFO - PROCESS | 2515 | _x_x_mozilla_page_load 10:46:16 INFO - PROCESS | 2515 | _x_x_mozilla_page_load_details 10:46:16 INFO - PROCESS | 2515 | |i|pagename|runs| 10:46:16 INFO - PROCESS | 2515 | |0;ai-astar;116;121;119;120;120;118;119;118;118;128 10:46:16 INFO - PROCESS | 2515 | |1;audio-beat-detection;140;134;104;189;111;135;146;142;137;125 10:46:16 INFO - PROCESS | 2515 | |2;audio-dft;200;203;194;207;201;196;195;179;266;200 10:46:16 INFO - PROCESS | 2515 | |3;audio-fft;79;77;86;79;76;55;64;81;97;86 10:46:16 INFO - PROCESS | 2515 | |4;audio-oscillator;85;73;86;73;75;60;103;106;105;114 10:46:16 INFO - PROCESS | 2515 | |5;imaging-gaussian-blur;89;88;89;88;91;103;99;87;90;86 10:46:16 INFO - PROCESS | 2515 | |6;imaging-darkroom;96;97;96;96;98;96;97;109;127;153 10:46:16 INFO - PROCESS | 2515 | |7;imaging-desaturate;149;153;94;96;99;125;92;92;95;92 10:46:16 INFO - PROCESS | 2515 | |8;json-parse-financial;58;57;62;67;85;99;92;82;61;62 10:46:16 INFO - PROCESS | 2515 | |9;json-stringify-tinderbox;70;74;84;102;116;88;74;76;75;74 10:46:16 INFO - PROCESS | 2515 | |10;stanford-crypto-aes;89;104;106;103;75;98;110;106;106;89 10:46:16 INFO - PROCESS | 2515 | |11;stanford-crypto-ccm;147;156;152;129;164;160;172;146;187;143 10:46:16 INFO - PROCESS | 2515 | |12;stanford-crypto-pbkdf2;169;171;168;208;173;167;170;167;171;167 10:46:16 INFO - PROCESS | 2515 | |13;stanford-crypto-sha256-iterative;67;68;66;67;66;66;84;86;71;66 10:46:16 INFO - PROCESS | 2515 | __end_tp_report 10:46:16 INFO - PROCESS | 2515 | __start_cc_report 10:46:16 INFO - PROCESS | 2515 | _x_x_mozilla_cycle_collect,944 10:46:16 INFO - PROCESS | 2515 | __end_cc_report 10:46:16 INFO - PROCESS | 2515 | __startTimestamp1486493176121__endTimestamp 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | ------- Summary: start ------- 10:46:16 INFO - PROCESS | 2515 | Number of tests: 14 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#0] ai-astar Cycles:10 Average:119.70 Median:119.50 stddev:3.23 (2.7%) stddev-sans-first:3.14 10:46:16 INFO - PROCESS | 2515 | Values: 116.0 121.0 119.0 120.0 120.0 118.0 119.0 118.0 118.0 128.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:138.50 stddev:22.94 (16.6%) stddev-sans-first:24.29 10:46:16 INFO - PROCESS | 2515 | Values: 140.0 134.0 104.0 189.0 111.0 135.0 146.0 142.0 137.0 125.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#2] audio-dft Cycles:10 Average:204.10 Median:200.50 stddev:23.01 (11.5%) stddev-sans-first:24.36 10:46:16 INFO - PROCESS | 2515 | Values: 200.0 203.0 194.0 207.0 201.0 196.0 195.0 179.0 266.0 200.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#3] audio-fft Cycles:10 Average:78.00 Median:80.00 stddev:11.69 (14.6%) stddev-sans-first:12.39 10:46:16 INFO - PROCESS | 2515 | Values: 79.0 77.0 86.0 79.0 76.0 55.0 64.0 81.0 97.0 86.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:73.00 stddev:18.04 (24.7%) stddev-sans-first:19.10 10:46:16 INFO - PROCESS | 2515 | Values: 85.0 73.0 86.0 73.0 75.0 60.0 103.0 106.0 105.0 114.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:89.00 stddev:5.54 (6.2%) stddev-sans-first:5.83 10:46:16 INFO - PROCESS | 2515 | Values: 89.0 88.0 89.0 88.0 91.0 103.0 99.0 87.0 90.0 86.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#6] imaging-darkroom Cycles:10 Average:106.50 Median:96.00 stddev:19.10 (19.9%) stddev-sans-first:19.87 10:46:16 INFO - PROCESS | 2515 | Values: 96.0 97.0 96.0 96.0 98.0 96.0 97.0 109.0 127.0 153.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#7] imaging-desaturate Cycles:10 Average:108.70 Median:93.00 stddev:24.38 (26.2%) stddev-sans-first:21.05 10:46:16 INFO - PROCESS | 2515 | Values: 149.0 153.0 94.0 96.0 99.0 125.0 92.0 92.0 95.0 92.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#8] json-parse-financial Cycles:10 Average:72.50 Median:74.50 stddev:15.50 (20.8%) stddev-sans-first:15.53 10:46:16 INFO - PROCESS | 2515 | Values: 58.0 57.0 62.0 67.0 85.0 99.0 92.0 82.0 61.0 62.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#9] json-stringify-tinderbox Cycles:10 Average:83.30 Median:74.50 stddev:14.91 (20.0%) stddev-sans-first:15.01 10:46:16 INFO - PROCESS | 2515 | Values: 70.0 74.0 84.0 102.0 116.0 88.0 74.0 76.0 75.0 74.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#10] stanford-crypto-aes Cycles:10 Average:98.60 Median:92.50 stddev:10.98 (11.9%) stddev-sans-first:11.08 10:46:16 INFO - PROCESS | 2515 | Values: 89.0 104.0 106.0 103.0 75.0 98.0 110.0 106.0 106.0 89.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:158.00 stddev:16.30 (10.3%) stddev-sans-first:16.99 10:46:16 INFO - PROCESS | 2515 | Values: 147.0 156.0 152.0 129.0 164.0 160.0 172.0 146.0 187.0 143.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:170.50 stddev:12.43 (7.3%) stddev-sans-first:13.10 10:46:16 INFO - PROCESS | 2515 | Values: 169.0 171.0 168.0 208.0 173.0 167.0 170.0 167.0 171.0 167.0 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - PROCESS | 2515 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:67.50 stddev:7.70 (11.4%) stddev-sans-first:8.05 10:46:16 INFO - PROCESS | 2515 | Values: 67.0 68.0 66.0 67.0 66.0 66.0 84.0 86.0 71.0 66.0 10:46:16 INFO - PROCESS | 2515 | -------- Summary: end -------- 10:46:16 INFO - PROCESS | 2515 | 10:46:16 INFO - TEST-INFO | 2515: exit 0 10:46:17 INFO - TEST-OK | kraken | took 61250ms 10:46:17 INFO - SUITE-END | took 1177s 10:46:17 INFO - Completed test suite (00:19:37) 10:46:17 INFO - javascript benchmark 10:46:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.87584450969, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.8650453981836, 3389.322135572886, 3397.2865698203377, 3408.982955085226, 3430.5711786026745, 5847.502962248209, 5887.85280367991, 5889.8822023559505, 5921.911171332428, 5937.58436909416, 5838.9124163137585, 5852.063669812831, 5861.8827623447505, 5881.0, 5884.176215329857, 5266.262723218752, 5325.653832500875, 5337.359516857982, 5368.70472124033, 5406.459354064582, 5364.034473794715, 5364.222187782769, 5380.0046991306535, 5382.6232163748555, 5443.265159203516, 5301.840944771644, 5307.708076055835, 5363.007843548937, 5365.195220716904, 5372.91940620891, 5310.973445132769, 5323.095073837457, 5361.651492652965, 5422.15956526739, 5439.646422982493, 5239.0, 5335.599830012726, 5354.330708661418, 5362.302900622894, 5396.298481197419, 5646.265985421869, 5813.186153938452, 5861.443162899561, 5919.437653422961, 5931.851703707399, 5894.585299528126, 6193.566450348478, 6221.595596286227, 6224.844378890519, 6288.842778930518, 5712.200291959129, 6347.952587823003, 6348.333424990402, 6355.936440635581, 6374.553781235315, 4983.626228032912, 5955.791547295824, 6010.879782404371, 6082.118092876508, 6098.298695650013, 5284.260203571426, 6222.595531290452, 6342.556021078481, 6394.104825324458, 6464.482841372679, 5517.565432987452, 5971.313298970587, 6143.174139895608, 6191.4118158774845, 6296.590721603081, 6300.3524044365795, 6357.427831495188, 6360.9045864312075, 6372.745090196433, 6378.808635740936, 5640.32316122068, 5799.072148456311, 6218.19163508741, 6236.937630623726, 6294.370562943669, 5162.767675454614, 5531.197976293415, 6044.607100538451, 6232.439080482778, 6308.211473565804, 5146.30524879144, 5152.4847515248175, 5154.613403994716, 5157.8452646420665, 5196.402413722471, 4431.512533621299, 4496.887577810516, 4558.111168322145, 4561.931571026437, 4586.3579098926175, 5972.223610930551, 5992.131140984533, 6018.15745795589, 6082.726277317532, 6123.357047509948, 6279.215098112736, 6371.426571608577, 6378.883695353387, 6380.330065343165, 6388.329225431263, 5762.279715035621, 5817.476427121579, 5927.644341339534, 5944.375840536768, 5979.372165922602, 5553.333599968029, 5604.3835178130375, 5623.184638227434, 5623.297087864017, 5639.887202255932, 6501.2523559791225, 6504.121943537656, 6518.478521718251, 6527.640979746159, 6550.967245163743, 6249.187605611241, 6255.562110652393, 6269.18500594938, 6285.49716022708, 6338.841528961812, 6459.354064593691, 6518.511111666549, 6537.673116344069, 6542.313057129123, 6547.574407663486, 6257.8748425030335, 6283.434490895841, 6312.905306420499, 6320.810375688737, 6343.9365606343345, 5325.0, 6143.262808463013, 6202.255729312331, 6238.6880655967925, 6336.8098957029515, 6204.565680402328, 6248.4376406123665, 6291.245050593958, 6294.024426213944, 6302.873942521215, 6214.25428948529, 6253.6560489173535, 6275.02737075754, 6276.372362763687, 6326.240851097898, 5972.70136493165, 6032.788852390146, 6051.848703782441, 6112.847178820565, 6184.381561843779, 6158.568900176944, 6164.260288765377, 6203.906941395973, 6255.78104766331, 6264.937350626436, 6153.538484613582, 6159.076138579249, 6176.135341052346, 6185.752569897154, 6192.0711893214575], "value": 5798.862417677679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.2103818317943, 474.746010884177, 488.7531796442798, 498.990020199596, 521.1531261699738, 38559.22881542371, 41394.58605413949, 41472.37791433131, 41569.0, 41920.37119443211, 42744.3588346175, 43163.3525497117, 43200.783996080056, 43367.0, 43417.13165736684, 8467.66129354825, 8691.435056721324, 9269.119433653808, 9507.477088760115, 9533.0, 11294.378809165493, 11696.7660646787, 11724.531018759239, 11807.881921180808, 11864.466099025522, 11367.204295699305, 11457.541698332057, 11622.953934145926, 11688.649340519798, 11702.707432314175, 11589.130815188895, 11624.593139240085, 11634.127440441916, 11646.883531164665, 11647.592334268345, 9602.0, 11463.36951467669, 11515.884841151565, 11521.48153333102, 11579.36313502757, 35421.40603672841, 40083.0, 41071.76784696464, 41409.378859317134, 41486.962825929295, 3988.840446382141, 4025.6175663311938, 4118.073433477473, 4126.360414135784, 4197.853075142355, 29992.0, 30446.391072178652, 30547.541786873215, 31505.21236969071, 32258.83870580632, 3292.456744637132, 3309.387763263804, 3323.3187196624635, 3390.0168951004425, 3417.726581873444, 440789.0, 441026.0, 446628.0, 446923.0, 447280.0, 62786.0, 63765.68117159477, 64004.67997659982, 64106.71786564243, 64204.35795641984, 67712.0, 68113.0, 68296.65851670809, 68343.97484037743, 68577.65711171413, 16541.917290413472, 16985.49043528696, 16996.915015424845, 17007.0, 17354.39259625907, 11074.335539867634, 11220.0, 12830.679233019062, 12940.0, 13113.409896554678, 15668.68662626741, 16163.545280924538, 17656.470305890845, 17673.0, 17717.7342339865, 5702.429757024264, 7001.194862590765, 7012.474064445187, 7032.367086962198, 7038.6480675965995, 795.0538858758059, 848.2535368875474, 884.0805562215353, 886.9512176830207, 900.5857305639479, 30333.0, 30750.84624576863, 30806.0, 30995.0701478956, 31107.844460777553, 1061.2624226162898, 1084.9891501085046, 1109.290054365207, 1114.1922106472744, 1222.3826967381594, 13663.111897726616, 14658.340374683165, 15506.379744810307, 15900.363985440454, 16551.751723724155, 602046.0, 602071.0, 602273.0, 602419.0, 605523.0, 54134.18798718022, 54178.64553386197, 54240.45759542433, 54342.72828635832, 54385.72807135939, 1227.766724322376, 1435.224978511592, 1435.3397437179015, 1449.340550049725, 1462.7805829125716, 28135.296617583906, 28983.85508072446, 29053.418931621673, 29191.270218243862, 29607.259818503848, 46699.76650116728, 46848.297275541576, 46899.8275043113, 47144.057118858116, 47239.87420566014, 528778.0, 531809.0, 532637.3368133134, 533258.0, 533904.0, 22361.44096397603, 23111.88444057769, 24399.39001524976, 25064.0, 25214.369640759127, 40306.596934031455, 42733.0, 42901.92745181396, 43297.56702432936, 43461.34807977946, 35250.47124293189, 35658.64341356657, 35711.75008874677, 35717.46423803593, 35835.0, 35464.936051918485, 35491.0, 35510.0, 35709.64290357063, 35795.0, 23251.76748232564, 29139.7086029137, 34440.79457218985, 34721.0, 35169.648303517664, 25911.352216194748, 30680.232994175323, 31970.6802931977, 32110.0, 32174.678253217167, 23660.290191294287, 23931.880340598185, 24052.27843164708, 24436.51126977486, 24501.0], "value": 19806.794595153526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5614620587972, 385.8572328238552, 395.91092004299054, 399.22948708991646, 402.0, 14253.572392828219, 21649.0, 22084.668729969024, 22127.080467077598, 22338.441538961513, 18795.906020469913, 19014.239430422767, 21842.907854607245, 22176.445588860246, 22247.888760556216, 5798.797042103527, 5820.097884827848, 5959.940400596003, 6039.728212230439, 6041.305249896274, 3710.6289371062812, 4400.361947517608, 5891.351951285376, 5992.910106348409, 5998.760049598032, 6316.115743795872, 6590.604563726168, 6645.700943457532, 6685.231198412172, 6709.261981182066, 5500.42245564218, 6502.992036234391, 6629.370209830058, 6658.434033107192, 6671.833204169886, 5799.507041901401, 5834.154047663107, 5837.036888913367, 5842.912356314659, 5867.530597552228, 11112.722181945435, 13657.521986730517, 23151.495152815012, 24476.877615611986, 25341.0, 2569.254916074336, 2631.6447279617196, 2682.248970288322, 2696.5955106734145, 2721.7958653101095, 10021.59913603455, 10095.646652367132, 10316.123129533999, 10752.193585481042, 10789.83815242772, 1797.757302764123, 1821.6812057889815, 1838.6690395728763, 1906.494778883597, 1913.818187272221, 95753.0, 125469.0, 129189.0, 130501.0, 132139.0, 11808.822867656992, 11817.0, 12134.089943254292, 12135.211211271238, 12148.696282593006, 15835.524934251991, 15887.364505419653, 15940.20298985046, 15940.92029539868, 15958.521244362688, 8863.468191908507, 9006.684766033157, 9051.094890511027, 9064.274858011344, 9102.499362535124, 7170.498065135391, 8751.168638979287, 8792.956035219911, 8827.16141966512, 8939.418937769024, 4307.030918043415, 4463.509014008457, 4859.392575928009, 4865.197242455026, 4921.655484116149, 1498.273337431345, 1690.4168062018584, 2058.752949646052, 2096.937091887246, 2107.346722516025, 1016.1201776713021, 1048.3343077146067, 1055.6832950114936, 1073.897979691928, 1075.6504136155625, 21678.45803854916, 22013.0, 22078.33764987053, 22099.668504972116, 22111.44721381946, 1046.7906418716286, 1089.8310761831929, 1092.4428541443922, 1093.1309608860975, 1104.436737264001, 9557.23542116629, 10984.835227471434, 11319.377434241196, 11436.085113190924, 12363.381830908418, 797018.0, 797082.0, 799658.0, 809906.0, 811357.0, 112245.0, 128951.0, 165992.0, 166090.0, 167221.0, 890.3411475508077, 912.8767616371838, 1059.4596755654673, 1082.9603580562748, 1088.1784252889177, 15205.315760791013, 16813.747793783346, 16819.24313405924, 16914.492565223063, 17744.46766597004, 46748.7662561685, 48534.0, 53729.38811835651, 54124.45875541194, 61419.0, 84247.5787621058, 87355.0, 87594.0, 88469.0, 89306.10693892978, 8163.755087347389, 8370.455920365157, 8502.78743031429, 8554.0, 8637.006744224494, 12231.816522752344, 12630.368481576068, 13333.799992999919, 13356.731110544482, 13793.310334483034, 9023.819523609622, 9118.0, 9408.388454750419, 10737.604111465773, 11618.012468940235, 9088.0, 10314.123299519324, 11160.720981975515, 11295.943520282346, 11418.771624567627, 11580.36308003068, 11643.417829108681, 11822.054235660955, 11879.643610691694, 11959.461824217757, 7331.74338898136, 8334.791455239078, 8348.998120225611, 8354.916450835413, 8700.651973921225, 9499.715008549754, 11228.101751859995, 11322.490487927898, 11576.768464630828, 11660.53357865676], "value": 9886.002931792338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.6517940156157, 1428.8213973253337, 1439.8920080993928, 1447.6091455307067, 1466.4427517543336, 7491.737789177379, 7747.070351557807, 8066.233707797757, 8508.276796472308, 8527.23254907059, 7567.826986817038, 7612.885806712904, 8354.874676879837, 8435.62039708213, 8463.788405289872, 2279.931602051937, 2322.4658328584437, 2329.184785325131, 2331.067572970817, 2339.0526836631193, 2069.665066032408, 2308.9307320780404, 2346.23747282134, 2366.2782851230368, 2370.7392186859433, 2062.7730949595534, 2245.371296037112, 2319.153508969231, 2325.883705814711, 2333.265021518225, 2278.737945136314, 2292.5758734634064, 2296.047140436725, 2302.9866858582172, 2305.561943230781, 2283.7602051784656, 2319.988400057989, 2346.5424242272766, 2350.4358953851124, 2351.564960482316, 8321.95839020801, 8423.789405264855, 8424.578771061422, 8429.789255268606, 8450.535220562866, 5064.063148317573, 5199.064168449678, 5210.76551555181, 5212.947870521322, 5214.582833373321, 2985.776066794999, 3508.5088087667746, 3560.946585801215, 3612.205314830733, 3632.3824949758605, 1050.8528805967171, 1218.8537375514995, 1244.8879600835878, 1260.8526241120537, 1274.1399555300136, 8419.494830310201, 10730.302530335503, 10789.082927951134, 10827.296225745302, 10886.183536234814, 4445.644348452116, 4700.858974230779, 4712.811487540528, 4767.475577686451, 4788.0, 9428.38715483505, 9526.90473095274, 9531.904680953241, 9540.0, 9547.33168678186, 5223.608229382811, 5270.631055826056, 5282.603804714585, 5285.445028272053, 5286.656367336188, 4561.498235194126, 4582.908341833145, 4751.738654374042, 4847.442544107473, 4854.101991131652, 3885.786281754474, 3901.6878649707955, 3926.6662333701383, 3977.482927219443, 3986.6412022918075, 1182.603827717707, 1232.0944106082022, 1284.0882973089024, 1287.819705241267, 1299.1685321394316, 763.9312461878458, 788.7436583110398, 803.7709252862905, 821.3059964330131, 853.8292341531718, 5447.591430642718, 5543.251661025791, 5649.915251271234, 5661.971690141523, 5670.319561652628, 987.1707765477033, 1018.0735530667057, 1024.3444195714749, 1030.4641586375044, 1054.947252637365, 3750.099976005739, 3794.3739283017994, 3842.558105817867, 3858.6527212551005, 3910.530736311604, 9487.193588545051, 9876.60493580263, 9902.405855648683, 10016.499175041365, 10166.390016599027, 8689.869651955225, 9414.764630884145, 9849.704508864745, 9862.802743945082, 9869.802603948025, 7702.576358300235, 7890.684372625031, 7904.802379940547, 7921.485103468256, 7921.76234712948, 4403.229434848825, 5454.836354909359, 5505.697186654612, 5805.448482394166, 5887.234659494238, 8566.0, 8962.462252264884, 9065.41074830134, 9142.451452912846, 9356.391834530734, 9219.44683319003, 9359.391639543408, 9369.578368973276, 9393.765155871159, 9416.670416535388, 7218.530795498275, 7290.781276561712, 7315.707371705073, 7341.265873412616, 7354.558726476428, 7714.922850771645, 7917.683292668229, 7948.761537153895, 8015.959920200362, 8045.5172689636465, 7106.040684507525, 7110.182329032021, 7140.892886606809, 7156.320149585781, 7253.963730181315, 6924.4114250287275, 6983.860322793617, 6984.930150698631, 6997.965010174917, 7012.789616311519, 6329.90505142414, 6349.428551430208, 6358.777442789666, 6416.165898433173, 6426.710798014007, 4815.422149342101, 4832.95167048339, 4867.878303042452, 4896.094222568836, 4911.484294149206, 4961.7519124044375, 4982.0, 4988.251762235694, 5016.272640467185, 5023.0], "value": 4414.792020427909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.788775327237, 324.97400207983355, 338.6765638814932, 350.4340490108474, 363.95086663300447, 5239.345081864767, 5349.839504814861, 5381.327334083239, 5476.58925580582, 5649.107548971089, 5012.423571289303, 5019.021290848286, 5224.320838291017, 5326.0, 5408.864778380543, 3721.683656889154, 4226.302660061094, 4293.205756934962, 4335.718178318415, 4349.0, 3343.665633436661, 4091.6112969267874, 4325.329573916048, 4331.4802223733195, 4373.890652733691, 4202.621764041236, 4205.095904380558, 4226.492820861486, 4226.873193804191, 4274.0597068645, 3766.058485378669, 3878.6230888034906, 4226.9154616907645, 4288.16380805743, 4319.719218250803, 3786.6109831700473, 3798.5631652360057, 3801.505804245458, 3816.580176180618, 3823.1780167264174, 4341.656924168373, 5174.2238664200295, 5227.830450363094, 5244.085908643356, 5297.735113244323, 4181.916361672749, 4329.480462344507, 4920.40955085392, 4959.429665588431, 4983.950160498421, 4624.791884365211, 5768.336641286264, 5808.954388210121, 5830.15462757902, 5830.416958304136, 3701.61133081028, 3726.3478891194204, 4070.735402198877, 4185.97907010463, 4209.326507758744, 6088.4215999479975, 6090.26916769986, 6102.96948515259, 6142.819299148827, 6181.505479561624, 4116.732412393245, 4241.1941731071, 4242.427272318259, 4252.723572967747, 4295.806688699016, 4222.577742225814, 4310.698251122391, 4315.546867578922, 4343.0, 4357.738535687806, 4295.312749959991, 4561.589456948891, 4950.108980383566, 4960.578350840219, 4998.325226094431, 5022.618779835501, 5392.67879369557, 5829.4170582942215, 5832.300123985064, 5877.735501902424, 1209.3046498263534, 1326.1777697827408, 1393.0805668259104, 1394.1008049807817, 1408.7323408552547, 943.528235882059, 949.3544389814992, 954.6372378496266, 975.5853762151199, 976.306822156277, 4344.523621535757, 4566.109608626286, 4931.9753401232765, 5101.372793011602, 5114.43741188469, 5343.225232341289, 5466.808661696901, 5708.74601477154, 5714.828555143353, 5749.080147176432, 4384.702991068771, 4579.885502862455, 4715.39272456571, 5202.687838729613, 5220.843374698765, 2715.3618899558983, 2986.5664481049216, 3002.6187953541616, 3016.2760937374874, 3034.4689679306034, 5023.321851550067, 5283.656562323436, 5825.300963884361, 5869.794557190563, 5964.508872781805, 5237.16205407133, 5350.652207606493, 5571.832845014656, 5701.657900525982, 5840.59115861894, 5796.42035796417, 5841.795537156179, 5859.853503662443, 5861.003629383101, 5873.4435374625755, 4922.572453988303, 5360.855657736781, 5366.175500329907, 5476.863078423071, 5735.483806457439, 4901.485344038967, 4927.359443272495, 5591.0, 5651.745671444877, 5656.971715141398, 5023.2214006829, 5857.619254748428, 5862.325832529314, 5870.354261031369, 5890.823275301748, 3233.6766323367474, 3708.406654935305, 3734.402495600691, 3757.8162878693124, 4002.579729128516, 4776.761161941959, 4776.785044672929, 5629.774809007594, 5632.957902787997, 5643.754840966542, 4948.826791062295, 5550.722463876871, 5568.691357531058, 5715.428457154251, 5810.418958104325, 5022.472640372708, 5596.720163991866, 5700.458456446631, 5730.312362516358, 5769.913451298318, 5326.682892941582, 5621.690807005654, 5631.436856314336, 5640.971795140998, 5675.716214189357, 4725.840351866856, 4917.360743103373, 5421.457854214547, 5834.27071616048, 5870.096385903326, 4886.511348865085, 5713.514351280021, 5715.314162300384, 5779.306483222041, 5781.0], "value": 4187.545208215499, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.2755189706496, 720.3444865172687, 759.3431681595422, 814.9755507334779, 840.4537050916904, 14278.643033924143, 14306.713865722679, 14721.190334531597, 14761.630959226011, 14882.479113231038, 14509.92745036276, 14706.55880323592, 14712.632184195401, 14718.705625887476, 15887.0, 865.0311650950944, 872.4852337121097, 891.9821603567925, 892.0633334998258, 893.2719833335843, 879.8680197970324, 885.8759773631697, 890.2566357091836, 890.4746199742151, 891.8751374807532, 926.5876684875233, 931.0, 934.6495064350869, 938.8779458670364, 943.2831048403194, 911.6717981526646, 919.9586018629144, 921.8018126102886, 923.1230331185367, 923.3674932671141, 687.0, 691.312144416309, 691.5297597633607, 692.9882371737269, 694.2086021934998, 15457.5362739118, 15833.920830395775, 15847.841521584753, 15894.602634934103, 15926.522204333773, 14136.434542618283, 14142.0, 14226.14643121416, 14276.857231427657, 14282.785758213635, 11670.35813030283, 11856.288622682667, 11876.524939002516, 11880.940595296968, 11905.583304584297, 3675.320065787811, 3677.0, 3689.714993804213, 3689.815509224528, 3758.586555478895, 102269.0, 102990.0, 103674.48162759213, 115196.0, 118113.0, 11133.554657813758, 11161.72781241455, 11227.0, 11461.598844040418, 11861.644150675493, 22150.778492215195, 22317.553648927256, 22503.324900253017, 22694.97872595737, 22971.770282297297, 7846.843063138819, 7857.0, 8003.559804210708, 8046.839063218703, 8242.835143297101, 4164.895877603084, 4177.143685544456, 4222.373704453766, 4296.2266791977745, 4335.1329734053315, 3503.3518799022263, 3569.607343192247, 3587.9282414352087, 3599.5320608321276, 3706.369917114097, 572.9828105156852, 675.5946432140677, 686.6703982088626, 695.0929037605872, 696.0186137546036, 656.5174596671443, 669.2544505420918, 678.6911955060435, 696.2967402923084, 728.7667946257146, 9521.143097121292, 10324.118873514793, 10414.635487757892, 11113.277636953571, 11491.0, 594.2007999241014, 597.7698586044318, 600.9819705408757, 614.50839328537, 720.9783706488814, 4482.013956929471, 4704.744141511382, 4791.305260737243, 4861.683990540603, 5143.074246635641, 91163.08836911678, 94847.0, 95918.0, 96347.51826240824, 96751.51624241975, 62067.689661551405, 68694.65652671705, 74782.8782568251, 83061.0, 84469.0, 59507.0, 76498.0, 77094.0, 77467.0, 77643.61178194186, 9845.212383009199, 9968.55141518619, 9977.251706121924, 9981.650642227487, 9995.600175992879, 49419.0, 49470.0, 49554.504454954986, 49809.256676016164, 50979.0, 62957.370426296984, 63750.0, 70975.0, 71517.28482715314, 73748.0, 13202.801957970447, 13265.270410127536, 13430.462781488632, 13451.548451548451, 13551.0, 14535.927320363331, 14586.416543338148, 14636.487722929647, 14945.476908308157, 15055.54833355001, 13142.73714525685, 13269.270190139636, 13550.457981680622, 14344.784828227794, 14570.781438278646, 13403.463861445824, 13509.864901351253, 13689.452421903012, 14268.643283917985, 14430.42278308856, 13058.738825223252, 13393.732125357634, 13706.451741930212, 14317.284135792961, 14412.919031072921, 10852.728681782703, 11465.426728663366, 11488.48301826403, 11523.947894301094, 11960.923516883522, 10043.899561004297, 10502.317349372266, 10573.312734672221, 11276.887231127585, 11582.826257605973], "value": 7564.412858610607, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 119.0, 120.0, 120.0, 118.0, 119.0, 118.0, 118.0, 128.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 104.0, 189.0, 111.0, 135.0, 146.0, 142.0, 137.0, 125.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 203.0, 194.0, 207.0, 201.0, 196.0, 195.0, 179.0, 266.0, 200.0], "value": 204.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 86.0, 79.0, 76.0, 55.0, 64.0, 81.0, 97.0, 86.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 86.0, 73.0, 75.0, 60.0, 103.0, 106.0, 105.0, 114.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 91.0, 103.0, 99.0, 87.0, 90.0, 86.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 98.0, 96.0, 97.0, 109.0, 127.0, 153.0], "value": 106.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 94.0, 96.0, 99.0, 125.0, 92.0, 92.0, 95.0, 92.0], "value": 108.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 62.0, 67.0, 85.0, 99.0, 92.0, 82.0, 61.0, 62.0], "value": 72.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 84.0, 102.0, 116.0, 88.0, 74.0, 76.0, 75.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 104.0, 106.0, 103.0, 75.0, 98.0, 110.0, 106.0, 106.0, 89.0], "value": 98.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 156.0, 152.0, 129.0, 164.0, 160.0, 172.0, 146.0, 187.0, 143.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 168.0, 208.0, 173.0, 167.0, 170.0, 167.0, 171.0, 167.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 67.0, 66.0, 66.0, 84.0, 86.0, 71.0, 66.0], "value": 70.7, "unit": "score"}]}]} 10:46:17 INFO - Return code: 0 10:46:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:46:17 ERROR - # TBPL SUCCESS # 10:46:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:46:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:46:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:46:17 INFO - 2017-02-07 10:46:17.425 screenresolution[2520:33151] starting screenresolution argv=screenresolution get 10:46:17 INFO - 2017-02-07 10:46:17.429 screenresolution[2520:33151] Display 0: 1600x1200x32@60 10:46:17 INFO - 2017-02-07 10:46:17.435 screenresolution[2521:33154] starting screenresolution argv=screenresolution list 10:46:17 INFO - Available Modes on Display 0 10:46:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:46:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:46:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:46:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:46:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:46:17 INFO - Intel Iris: 10:46:17 INFO - Chipset Model: Intel Iris 10:46:17 INFO - Type: GPU 10:46:17 INFO - Bus: Built-In 10:46:17 INFO - VRAM (Dynamic, Max): 1536 MB 10:46:17 INFO - Vendor: Intel (0x8086) 10:46:17 INFO - Device ID: 0x0a2e 10:46:17 INFO - Revision ID: 0x0009 10:46:17 INFO - Displays: 10:46:17 INFO - Display: 10:46:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:46:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:46:17 INFO - Display Serial Number: 1600x1200 60 10:46:17 INFO - Main Display: Yes 10:46:17 INFO - Mirror: Off 10:46:17 INFO - Online: Yes 10:46:17 INFO - Rotation: Supported 10:46:17 INFO - Return code: 0 10:46:17 INFO - Running post-action listener: _resource_record_post_action 10:46:17 INFO - [mozharness: 2017-02-07 18:46:17.675545Z] Finished run-tests step (success) 10:46:17 INFO - Running post-run listener: _resource_record_post_run 10:46:17 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 1344000; Write bytes: 510220288; Read time: 32; Write time: 1631 10:46:17 INFO - TinderboxPrint: CPU usage
54.4% 10:46:17 INFO - TinderboxPrint: I/O read bytes / time
1,344,000 / 32 10:46:17 INFO - TinderboxPrint: I/O write bytes / time
510,220,288 / 1,631 10:46:17 INFO - TinderboxPrint: CPU idle
2,187.3 (45.6%) 10:46:17 INFO - TinderboxPrint: CPU system
973.3 (20.3%) 10:46:17 INFO - TinderboxPrint: CPU user
1,633.2 (34.1%) 10:46:17 INFO - TinderboxPrint: Swap in / out
208,502,784 / 0 10:46:17 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205136384; Write bytes: 204920832; Read time: 15697; Write time: 459 10:46:17 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1229312; Write bytes: 298549248; Read time: 29; Write time: 1144 10:46:18 INFO - Running post-run listener: _upload_blobber_files 10:46:18 INFO - Blob upload gear active. 10:46:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:46:18 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 10:46:18 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'] 10:46:18 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 10:46:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:19 INFO - (blobuploader) - INFO - Done attempting. 10:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:20 INFO - (blobuploader) - INFO - Done attempting. 10:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:21 INFO - (blobuploader) - INFO - Done attempting. 10:46:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:46:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:23 INFO - (blobuploader) - INFO - Done attempting. 10:46:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:46:23 INFO - Return code: 0 10:46:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:46:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:46:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25242cf3314dce75a4b2b498846737a6f9d29b9c2ff09d3ad52d7af1865ceb584ac144413f2171a781218cbe48899a5212ebe057498887ea5cf5310a48af7603", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce0a187fd2e4db973b5c063b3ff8aba706955270539c04045a1765b1494eb86131a82559ee69a87c210f1152518ee2b75c19c33c1161b57e94dfc54901f42f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9967e25fb4864dd45e4f21612311dd871276d5f74c07ac7037a91ed990073e50d0134878246bc9668f5e9e60cda344f2dac70549a613192e6b7863d93c2e8bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8795b57489d8704bcf43fedf2842e3668aae6468baa847316c399156198ab1c84cc35c8a915836f904f0fee14595887aeec92bd98e23b1985818ea1a51267713"} 10:46:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:46:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:46:23 INFO - Contents: 10:46:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25242cf3314dce75a4b2b498846737a6f9d29b9c2ff09d3ad52d7af1865ceb584ac144413f2171a781218cbe48899a5212ebe057498887ea5cf5310a48af7603", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce0a187fd2e4db973b5c063b3ff8aba706955270539c04045a1765b1494eb86131a82559ee69a87c210f1152518ee2b75c19c33c1161b57e94dfc54901f42f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9967e25fb4864dd45e4f21612311dd871276d5f74c07ac7037a91ed990073e50d0134878246bc9668f5e9e60cda344f2dac70549a613192e6b7863d93c2e8bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8795b57489d8704bcf43fedf2842e3668aae6468baa847316c399156198ab1c84cc35c8a915836f904f0fee14595887aeec92bd98e23b1985818ea1a51267713"} 10:46:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:46:23 INFO - Copying logs to upload dir... 10:46:23 INFO - mkdir: /builds/slave/test/build/upload/logs 10:46:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.678342 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-07 10:46:23.906595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 10:46:23.909760) ========= 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.0eQqOQNkzs/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.DtZObXscE9/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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/25242cf3314dce75a4b2b498846737a6f9d29b9c2ff09d3ad52d7af1865ceb584ac144413f2171a781218cbe48899a5212ebe057498887ea5cf5310a48af7603", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce0a187fd2e4db973b5c063b3ff8aba706955270539c04045a1765b1494eb86131a82559ee69a87c210f1152518ee2b75c19c33c1161b57e94dfc54901f42f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9967e25fb4864dd45e4f21612311dd871276d5f74c07ac7037a91ed990073e50d0134878246bc9668f5e9e60cda344f2dac70549a613192e6b7863d93c2e8bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8795b57489d8704bcf43fedf2842e3668aae6468baa847316c399156198ab1c84cc35c8a915836f904f0fee14595887aeec92bd98e23b1985818ea1a51267713"} build_url:https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/NOERDN4qRdCid62JaRBvEw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25242cf3314dce75a4b2b498846737a6f9d29b9c2ff09d3ad52d7af1865ceb584ac144413f2171a781218cbe48899a5212ebe057498887ea5cf5310a48af7603", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce0a187fd2e4db973b5c063b3ff8aba706955270539c04045a1765b1494eb86131a82559ee69a87c210f1152518ee2b75c19c33c1161b57e94dfc54901f42f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9967e25fb4864dd45e4f21612311dd871276d5f74c07ac7037a91ed990073e50d0134878246bc9668f5e9e60cda344f2dac70549a613192e6b7863d93c2e8bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8795b57489d8704bcf43fedf2842e3668aae6468baa847316c399156198ab1c84cc35c8a915836f904f0fee14595887aeec92bd98e23b1985818ea1a51267713"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 10:46:23.943949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:46:23.944282) ========= 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.0eQqOQNkzs/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.DtZObXscE9/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005533 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:46:23.993238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 10:46:23.993566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 10:46:23.993898) ========= ========= Total master_lag: 0.18 =========