builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0002 starttime: 1486410349.54 results: success (0) buildid: 20170206101454 builduid: ce72679dd94a49a78e279689de5f532b revision: 05fae22830c0365b8173be4a2584ff0375b547a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.539005) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.539457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.539795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.564949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.565341) ========= 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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-06 11:45:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-02-06 11:45:49 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109140 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.698025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.698340) ========= 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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.020218 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:49.747435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 11:45:49.747800) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 05fae22830c0365b8173be4a2584ff0375b547a1 --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 05fae22830c0365b8173be4a2584ff0375b547a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lCOSmp9jf3/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.iDzAUDtmLL/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-06 11:45:49,833 truncating revision to first 12 chars 2017-02-06 11:45:49,833 Setting DEBUG logging. 2017-02-06 11:45:49,833 attempt 1/10 2017-02-06 11:45:49,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/05fae22830c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 11:45:50,805 unpacking tar archive at: mozilla-aurora-05fae22830c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 11:45:51.005303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:51.005638) ========= script_repo_revision: 05fae22830c0365b8173be4a2584ff0375b547a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:51.006024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:51.006306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:51.026459) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-06 11:45:51.026912) ========= /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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:45:51 INFO - MultiFileLogger online at 20170206 11:45:51 in /builds/slave/test 11:45:51 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 11:45:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:45:51 INFO - {'append_to_log': False, 11:45:51 INFO - 'base_work_dir': '/builds/slave/test', 11:45:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:45:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:45:51 INFO - 'branch': 'Mozilla-Aurora', 11:45:51 INFO - 'buildbot_json_path': 'buildprops.json', 11:45:51 INFO - 'config_files': ('talos/mac_config.py',), 11:45:51 INFO - 'default_actions': ('clobber', 11:45:51 INFO - 'read-buildbot-config', 11:45:51 INFO - 'download-and-extract', 11:45:51 INFO - 'populate-webroot', 11:45:51 INFO - 'create-virtualenv', 11:45:51 INFO - 'install', 11:45:51 INFO - 'run-tests'), 11:45:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:45:51 INFO - 'download_minidump_stackwalk': True, 11:45:51 INFO - 'download_symbols': 'ondemand', 11:45:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:45:51 INFO - 'tooltool.py': '/tools/tooltool.py', 11:45:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:45:51 INFO - '/tools/misc-python/virtualenv.py')}, 11:45:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:45:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:45:51 INFO - 'installer_path': 'installer.exe', 11:45:51 INFO - 'log_level': 'info', 11:45:51 INFO - 'log_name': 'talos', 11:45:51 INFO - 'log_to_console': True, 11:45:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:45:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:45:51 INFO - 'opt_config_files': (), 11:45:51 INFO - 'pip_index': False, 11:45:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:45:51 INFO - 'cmd': ('bash', 11:45:51 INFO - '-c', 11:45:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:45:51 INFO - 'enabled': True, 11:45:51 INFO - 'halt_on_failure': False, 11:45:51 INFO - 'name': 'check_screen_resolution'},), 11:45:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:45:51 INFO - 'cmd': ('bash', 11:45:51 INFO - '-c', 11:45:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:45:51 INFO - 'enabled': True, 11:45:51 INFO - 'halt_on_failure': False, 11:45:51 INFO - 'name': 'check_screen_resolution'},), 11:45:51 INFO - 'run_cmd_checks_enabled': True, 11:45:51 INFO - 'sps_profile': False, 11:45:51 INFO - 'sps_profile_interval': 0, 11:45:51 INFO - 'suite': 'dromaeojs-e10s', 11:45:51 INFO - 'system_bits': '32', 11:45:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:45:51 INFO - 'title': 't-yosemite-r7-0002', 11:45:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:45:51 INFO - 'use_talos_json': True, 11:45:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:45:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:45:51 INFO - 'work_dir': 'build'} 11:45:51 INFO - [mozharness: 2017-02-06 19:45:51.239397Z] Running clobber step. 11:45:51 INFO - Running pre-action listener: _resource_record_pre_action 11:45:51 INFO - Running main action method: clobber 11:45:51 INFO - rmtree: /builds/slave/test/build 11:45:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:45:52 INFO - Running post-action listener: _resource_record_post_action 11:45:52 INFO - [mozharness: 2017-02-06 19:45:52.859027Z] Finished clobber step (success) 11:45:52 INFO - [mozharness: 2017-02-06 19:45:52.859202Z] Running read-buildbot-config step. 11:45:52 INFO - Running pre-action listener: _resource_record_pre_action 11:45:52 INFO - Running main action method: read_buildbot_config 11:45:52 INFO - Using buildbot properties: 11:45:52 INFO - { 11:45:52 INFO - "project": "", 11:45:52 INFO - "product": "firefox", 11:45:52 INFO - "script_repo_revision": "production", 11:45:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 11:45:52 INFO - "repository": "", 11:45:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 11:45:52 INFO - "buildid": "20170206101454", 11:45:52 INFO - "pgo_build": "False", 11:45:52 INFO - "basedir": "/builds/slave/test", 11:45:52 INFO - "buildnumber": 29, 11:45:52 INFO - "slavename": "t-yosemite-r7-0002", 11:45:52 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:45:52 INFO - "platform": "yosemite_r7", 11:45:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:45:52 INFO - "branch": "mozilla-aurora", 11:45:52 INFO - "repo_path": "releases/mozilla-aurora", 11:45:52 INFO - "revision": "05fae22830c0365b8173be4a2584ff0375b547a1", 11:45:52 INFO - "stage_platform": "macosx64", 11:45:52 INFO - "builduid": "ce72679dd94a49a78e279689de5f532b", 11:45:52 INFO - "slavebuilddir": "test" 11:45:52 INFO - } 11:45:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:45:52 INFO - Running post-action listener: _resource_record_post_action 11:45:52 INFO - [mozharness: 2017-02-06 19:45:52.862665Z] Finished read-buildbot-config step (success) 11:45:52 INFO - [mozharness: 2017-02-06 19:45:52.862776Z] Running download-and-extract step. 11:45:52 INFO - Running pre-action listener: _resource_record_pre_action 11:45:52 INFO - Running main action method: download_and_extract 11:45:52 INFO - mkdir: /builds/slave/test/build/tests 11:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:52 INFO - trying https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:45:52 INFO - Downloading https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/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 11:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/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 11:45:54 INFO - Downloaded 1199 bytes. 11:45:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:45:54 INFO - Using the following test package requirements: 11:45:54 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:45:54 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:45:54 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:45:54 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'jsshell-mac.zip'], 11:45:54 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:45:54 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:45:54 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:45:54 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:45:54 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:45:54 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:45:54 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:45:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:45:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:45:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:45:54 INFO - Fetch https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:45:55 INFO - Expected file size: 16356103 11:45:55 INFO - Obtained file size: 16356103 11:46:01 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 11:46:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:46:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:46:01 INFO - Fetch https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:46:02 INFO - Expected file size: 16356103 11:46:02 INFO - Obtained file size: 16356103 11:46:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:46:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:46:08 INFO - Fetch https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:46:09 INFO - Expected file size: 14403485 11:46:09 INFO - Obtained file size: 14403485 11:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:10 INFO - trying https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:46:10 INFO - Downloading https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/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 11:46:12 INFO - Downloaded 73831103 bytes. 11:46:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:46:12 INFO - mkdir: /builds/slave/test/properties 11:46:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:46:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:46:12 INFO - Contents: 11:46:12 INFO - build_url:https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:46:12 INFO - Running post-action listener: _resource_record_post_action 11:46:12 INFO - Running post-action listener: set_extra_try_arguments 11:46:12 INFO - [mozharness: 2017-02-06 19:46:12.790913Z] Finished download-and-extract step (success) 11:46:12 INFO - [mozharness: 2017-02-06 19:46:12.791029Z] Running populate-webroot step. 11:46:12 INFO - Running pre-action listener: _resource_record_pre_action 11:46:12 INFO - Running main action method: populate_webroot 11:46:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:46:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:46:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:46:12 INFO - '--tppagecycles', 11:46:12 INFO - '7'], 11:46:12 INFO - 'tests': ['tsvgm']}}, 11:46:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:46:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:46:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:46:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:46:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:46:12 INFO - 'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:46:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:46:12 INFO - 'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['damp', 'tps']}, 11:46:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:46:12 INFO - 'tests': ['damp', 'tps']}, 11:46:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['dromaeo_dom']}, 11:46:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:46:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['basic_compositor_video']}, 11:46:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:46:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['a11yr', 11:46:12 INFO - 'ts_paint', 11:46:12 INFO - 'tpaint', 11:46:12 INFO - 'sessionrestore', 11:46:12 INFO - 'sessionrestore_no_auto_restore', 11:46:12 INFO - 'tabpaint']}, 11:46:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:46:12 INFO - 'ts_paint', 11:46:12 INFO - 'tpaint', 11:46:12 INFO - 'sessionrestore', 11:46:12 INFO - 'sessionrestore_no_auto_restore', 11:46:12 INFO - 'tabpaint']}, 11:46:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:46:12 INFO - 'ts_paint', 11:46:12 INFO - 'tpaint', 11:46:12 INFO - 'sessionrestore', 11:46:12 INFO - 'sessionrestore_no_auto_restore', 11:46:12 INFO - 'tabpaint']}, 11:46:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:46:12 INFO - 'ts_paint', 11:46:12 INFO - 'tpaint', 11:46:12 INFO - 'sessionrestore', 11:46:12 INFO - 'sessionrestore_no_auto_restore', 11:46:12 INFO - 'tabpaint']}, 11:46:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['a11yr', 11:46:12 INFO - 'ts_paint', 11:46:12 INFO - 'tpaint', 11:46:12 INFO - 'sessionrestore', 11:46:12 INFO - 'sessionrestore_no_auto_restore', 11:46:12 INFO - 'tabpaint']}, 11:46:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['a11yr', 11:46:12 INFO - 'ts_paint', 11:46:12 INFO - 'tpaint', 11:46:12 INFO - 'sessionrestore', 11:46:12 INFO - 'sessionrestore_no_auto_restore', 11:46:12 INFO - 'tabpaint']}, 11:46:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['tsvgx', 11:46:12 INFO - 'tsvgr_opacity', 11:46:12 INFO - 'tart', 11:46:12 INFO - 'tscrollx', 11:46:12 INFO - 'cart', 11:46:12 INFO - 'tsvg_static']}, 11:46:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:46:12 INFO - 'tsvgr_opacity', 11:46:12 INFO - 'tart', 11:46:12 INFO - 'tscrollx', 11:46:12 INFO - 'cart', 11:46:12 INFO - 'tsvg_static']}, 11:46:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:46:12 INFO - 'talos_options': ['--disable-e10s'], 11:46:12 INFO - 'tests': ['tp5o']}, 11:46:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:46:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:46:12 INFO - 'talos_options': ['--disable-e10s', 11:46:12 INFO - '--xperf_path', 11:46:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:12 INFO - 'tests': ['tp5n']}, 11:46:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:46:12 INFO - 'talos_options': ['--xperf_path', 11:46:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:12 INFO - 'tests': ['tp5n']}}, 11:46:12 INFO - 'talos.zip': {'path': '', 11:46:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:46:12 INFO - Running post-action listener: _resource_record_post_action 11:46:12 INFO - [mozharness: 2017-02-06 19:46:12.809720Z] Finished populate-webroot step (success) 11:46:12 INFO - [mozharness: 2017-02-06 19:46:12.809809Z] Running create-virtualenv step. 11:46:12 INFO - Running pre-action listener: _resource_record_pre_action 11:46:12 INFO - Running main action method: create_virtualenv 11:46:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:46:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:46:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:46:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:46:12 INFO - Using real prefix '/tools/python27' 11:46:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:46:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:46:16 INFO - Installing pip.................done. 11:46:16 INFO - Return code: 0 11:46:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:46:16 INFO - Reading from file tmpfile_stdout 11:46:16 INFO - Output received: 11:46:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:46:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:16 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 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:16 INFO - 'HOME': '/Users/cltbld', 11:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:16 INFO - 'LOGNAME': 'cltbld', 11:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:16 INFO - 'MOZ_NO_REMOTE': '1', 11:46:16 INFO - 'NO_EM_RESTART': '1', 11:46:16 INFO - 'PAGER': '/bin/cat', 11:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:16 INFO - 'PWD': '/builds/slave/test', 11:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:16 INFO - 'SHELL': '/bin/bash', 11:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:16 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:16 INFO - 'USER': 'cltbld', 11:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:16 INFO - 'XPC_FLAGS': '0x0', 11:46:16 INFO - 'XPC_SERVICE_NAME': '0', 11:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:46:16 INFO - Cleaning up... 11:46:17 INFO - Return code: 0 11:46:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:46:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:17 INFO - 'HOME': '/Users/cltbld', 11:46:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:17 INFO - 'LOGNAME': 'cltbld', 11:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:17 INFO - 'MOZ_NO_REMOTE': '1', 11:46:17 INFO - 'NO_EM_RESTART': '1', 11:46:17 INFO - 'PAGER': '/bin/cat', 11:46:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:17 INFO - 'PWD': '/builds/slave/test', 11:46:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:17 INFO - 'SHELL': '/bin/bash', 11:46:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:17 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:17 INFO - 'USER': 'cltbld', 11:46:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:17 INFO - 'XPC_FLAGS': '0x0', 11:46:17 INFO - 'XPC_SERVICE_NAME': '0', 11:46:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:17 INFO - Downloading/unpacking psutil>=3.1.1 11:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:46:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:20 INFO - Installing collected packages: psutil 11:46:20 INFO - Running setup.py install for psutil 11:46:21 INFO - building 'psutil._psutil_osx' extension 11:46:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:46:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:46:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:46:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:46:21 INFO - building 'psutil._psutil_posix' extension 11:46:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:46:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:46:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:46:21 INFO - ^ 11:46:21 INFO - 1 warning generated. 11:46:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:46:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:21 INFO - Successfully installed psutil 11:46:21 INFO - Cleaning up... 11:46:21 INFO - Return code: 0 11:46:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:21 INFO - 'HOME': '/Users/cltbld', 11:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:21 INFO - 'LOGNAME': 'cltbld', 11:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:21 INFO - 'MOZ_NO_REMOTE': '1', 11:46:21 INFO - 'NO_EM_RESTART': '1', 11:46:21 INFO - 'PAGER': '/bin/cat', 11:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:21 INFO - 'PWD': '/builds/slave/test', 11:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:21 INFO - 'SHELL': '/bin/bash', 11:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:21 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:21 INFO - 'USER': 'cltbld', 11:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:21 INFO - 'XPC_FLAGS': '0x0', 11:46:21 INFO - 'XPC_SERVICE_NAME': '0', 11:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:46:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:46:24 INFO - Installing collected packages: mozsystemmonitor 11:46:24 INFO - Running setup.py install for mozsystemmonitor 11:46:24 INFO - Successfully installed mozsystemmonitor 11:46:24 INFO - Cleaning up... 11:46:25 INFO - Return code: 0 11:46:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:25 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 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:25 INFO - 'HOME': '/Users/cltbld', 11:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:25 INFO - 'LOGNAME': 'cltbld', 11:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:25 INFO - 'MOZ_NO_REMOTE': '1', 11:46:25 INFO - 'NO_EM_RESTART': '1', 11:46:25 INFO - 'PAGER': '/bin/cat', 11:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:25 INFO - 'PWD': '/builds/slave/test', 11:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:25 INFO - 'SHELL': '/bin/bash', 11:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:25 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:25 INFO - 'USER': 'cltbld', 11:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:25 INFO - 'XPC_FLAGS': '0x0', 11:46:25 INFO - 'XPC_SERVICE_NAME': '0', 11:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:25 INFO - Downloading/unpacking jsonschema==2.5.1 11:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:46:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:46:28 INFO - warning: no files found matching '*.txt' 11:46:28 INFO - no previously-included directories found matching 'build' 11:46:28 INFO - no previously-included directories found matching 'dist' 11:46:28 INFO - no previously-included directories found matching '.git*' 11:46:28 INFO - Installing collected packages: jsonschema, functools32 11:46:28 INFO - Running setup.py install for functools32 11:46:28 INFO - warning: no files found matching '*.txt' 11:46:28 INFO - no previously-included directories found matching 'build' 11:46:28 INFO - no previously-included directories found matching 'dist' 11:46:28 INFO - no previously-included directories found matching '.git*' 11:46:28 INFO - Successfully installed jsonschema functools32 11:46:28 INFO - Cleaning up... 11:46:28 INFO - Return code: 0 11:46:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:28 INFO - 'HOME': '/Users/cltbld', 11:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:28 INFO - 'LOGNAME': 'cltbld', 11:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:28 INFO - 'MOZ_NO_REMOTE': '1', 11:46:28 INFO - 'NO_EM_RESTART': '1', 11:46:28 INFO - 'PAGER': '/bin/cat', 11:46:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:28 INFO - 'PWD': '/builds/slave/test', 11:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:28 INFO - 'SHELL': '/bin/bash', 11:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:28 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:28 INFO - 'USER': 'cltbld', 11:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:28 INFO - 'XPC_FLAGS': '0x0', 11:46:28 INFO - 'XPC_SERVICE_NAME': '0', 11:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:46:28 INFO - Cleaning up... 11:46:28 INFO - Return code: 0 11:46:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:28 INFO - 'HOME': '/Users/cltbld', 11:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:28 INFO - 'LOGNAME': 'cltbld', 11:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:28 INFO - 'MOZ_NO_REMOTE': '1', 11:46:28 INFO - 'NO_EM_RESTART': '1', 11:46:28 INFO - 'PAGER': '/bin/cat', 11:46:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:28 INFO - 'PWD': '/builds/slave/test', 11:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:28 INFO - 'SHELL': '/bin/bash', 11:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:28 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:28 INFO - 'USER': 'cltbld', 11:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:28 INFO - 'XPC_FLAGS': '0x0', 11:46:28 INFO - 'XPC_SERVICE_NAME': '0', 11:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:29 INFO - Downloading/unpacking blobuploader==1.2.4 11:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:31 INFO - Downloading blobuploader-1.2.4.tar.gz 11:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:46:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:46:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:33 INFO - Downloading docopt-0.6.1.tar.gz 11:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:46:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:46:33 INFO - Running setup.py install for blobuploader 11:46:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:46:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:46:33 INFO - Running setup.py install for requests 11:46:33 INFO - Running setup.py install for docopt 11:46:33 INFO - Successfully installed blobuploader requests docopt 11:46:33 INFO - Cleaning up... 11:46:34 INFO - Return code: 0 11:46:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:34 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 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:46:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:34 INFO - 'HOME': '/Users/cltbld', 11:46:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:34 INFO - 'LOGNAME': 'cltbld', 11:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:34 INFO - 'MOZ_NO_REMOTE': '1', 11:46:34 INFO - 'NO_EM_RESTART': '1', 11:46:34 INFO - 'PAGER': '/bin/cat', 11:46:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:34 INFO - 'PWD': '/builds/slave/test', 11:46:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:34 INFO - 'SHELL': '/bin/bash', 11:46:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:34 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:34 INFO - 'USER': 'cltbld', 11:46:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:34 INFO - 'XPC_FLAGS': '0x0', 11:46:34 INFO - 'XPC_SERVICE_NAME': '0', 11:46:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vd_JEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Jwggjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-bboT6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-XKbKfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Ayx4B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-fov7T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-w7OQMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ayv1mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-QwemdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Zyehgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-DMhXdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Fiz3jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-nkrzeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-bMLpam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-0xnhSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Xe8pBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:36 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-gx7bix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:46:36 INFO - Running setup.py install for manifestparser 11:46:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:46:36 INFO - Running setup.py install for mozcrash 11:46:36 INFO - Running setup.py install for mozdebug 11:46:36 INFO - Running setup.py install for mozdevice 11:46:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:46:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:46:36 INFO - Running setup.py install for mozfile 11:46:36 INFO - Running setup.py install for mozhttpd 11:46:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Running setup.py install for mozinfo 11:46:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Running setup.py install for mozInstall 11:46:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Running setup.py install for mozleak 11:46:37 INFO - Running setup.py install for mozlog 11:46:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Running setup.py install for moznetwork 11:46:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:46:37 INFO - Running setup.py install for mozprocess 11:46:37 INFO - Running setup.py install for mozprofile 11:46:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:46:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:46:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:46:38 INFO - Running setup.py install for mozrunner 11:46:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:46:38 INFO - Running setup.py install for mozscreenshot 11:46:38 INFO - Running setup.py install for moztest 11:46:38 INFO - Running setup.py install for mozversion 11:46:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:46:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:46:38 INFO - Cleaning up... 11:46:38 INFO - Return code: 0 11:46:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:38 INFO - 'HOME': '/Users/cltbld', 11:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:38 INFO - 'LOGNAME': 'cltbld', 11:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:38 INFO - 'MOZ_NO_REMOTE': '1', 11:46:38 INFO - 'NO_EM_RESTART': '1', 11:46:38 INFO - 'PAGER': '/bin/cat', 11:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:38 INFO - 'PWD': '/builds/slave/test', 11:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:38 INFO - 'SHELL': '/bin/bash', 11:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:38 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:38 INFO - 'USER': 'cltbld', 11:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:38 INFO - 'XPC_FLAGS': '0x0', 11:46:38 INFO - 'XPC_SERVICE_NAME': '0', 11:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zXGxfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-r52Ux3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Ev4SVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-QFsVw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-0SSAez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-t7BMhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-cWnwmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-NTZI60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-n6Ks25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:39 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UW_E41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:40 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-JErDMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:40 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-hIjgj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:40 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-YUHFEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:40 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-sIRlOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:40 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-LrTq7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:40 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-sfzaqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:40 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-XsT6fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:46:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:43 INFO - Downloading blessings-1.6.tar.gz 11:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:46:43 INFO - Installing collected packages: blessings 11:46:43 INFO - Running setup.py install for blessings 11:46:43 INFO - Successfully installed blessings 11:46:43 INFO - Cleaning up... 11:46:43 INFO - Return code: 0 11:46:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:44 INFO - Reading from file tmpfile_stdout 11:46:44 INFO - Current package versions: 11:46:44 INFO - blessings == 1.6 11:46:44 INFO - blobuploader == 1.2.4 11:46:44 INFO - docopt == 0.6.1 11:46:44 INFO - functools32 == 3.2.3-2 11:46:44 INFO - jsonschema == 2.5.1 11:46:44 INFO - manifestparser == 1.1 11:46:44 INFO - mozInstall == 1.12 11:46:44 INFO - mozcrash == 1.0 11:46:44 INFO - mozdebug == 0.1 11:46:44 INFO - mozdevice == 0.49 11:46:44 INFO - mozfile == 1.2 11:46:44 INFO - mozhttpd == 0.7 11:46:44 INFO - mozinfo == 0.9 11:46:44 INFO - mozleak == 0.1 11:46:44 INFO - mozlog == 3.4 11:46:44 INFO - moznetwork == 0.27 11:46:44 INFO - mozprocess == 0.24 11:46:44 INFO - mozprofile == 0.28 11:46:44 INFO - mozrunner == 6.13 11:46:44 INFO - mozscreenshot == 0.1 11:46:44 INFO - mozsystemmonitor == 0.3 11:46:44 INFO - moztest == 0.8 11:46:44 INFO - mozversion == 1.4 11:46:44 INFO - psutil == 3.1.1 11:46:44 INFO - requests == 1.2.3 11:46:44 INFO - wsgiref == 0.1.2 11:46:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 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 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:44 INFO - 'HOME': '/Users/cltbld', 11:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:44 INFO - 'LOGNAME': 'cltbld', 11:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:44 INFO - 'MOZ_NO_REMOTE': '1', 11:46:44 INFO - 'NO_EM_RESTART': '1', 11:46:44 INFO - 'PAGER': '/bin/cat', 11:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:44 INFO - 'PWD': '/builds/slave/test', 11:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:44 INFO - 'SHELL': '/bin/bash', 11:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:44 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:44 INFO - 'USER': 'cltbld', 11:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:44 INFO - 'XPC_FLAGS': '0x0', 11:46:44 INFO - 'XPC_SERVICE_NAME': '0', 11:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:46:44 INFO - Cleaning up... 11:46:44 INFO - Return code: 0 11:46:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 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 0x104814b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104817768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d8570430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, '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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:44 INFO - 'HOME': '/Users/cltbld', 11:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:44 INFO - 'LOGNAME': 'cltbld', 11:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:44 INFO - 'MOZ_NO_REMOTE': '1', 11:46:44 INFO - 'NO_EM_RESTART': '1', 11:46:44 INFO - 'PAGER': '/bin/cat', 11:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:44 INFO - 'PWD': '/builds/slave/test', 11:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:44 INFO - 'SHELL': '/bin/bash', 11:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:46:44 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:44 INFO - 'USER': 'cltbld', 11:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:44 INFO - 'XPC_FLAGS': '0x0', 11:46:44 INFO - 'XPC_SERVICE_NAME': '0', 11:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:46:44 INFO - Cleaning up... 11:46:44 INFO - Return code: 0 11:46:44 INFO - Running post-action listener: _resource_record_post_action 11:46:44 INFO - Running post-action listener: _start_resource_monitoring 11:46:44 INFO - Starting resource monitoring. 11:46:44 INFO - [mozharness: 2017-02-06 19:46:44.661632Z] Finished create-virtualenv step (success) 11:46:44 INFO - [mozharness: 2017-02-06 19:46:44.662602Z] Running install step. 11:46:44 INFO - Running pre-action listener: _resource_record_pre_action 11:46:44 INFO - Running main action method: install 11:46:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:44 INFO - Reading from file tmpfile_stdout 11:46:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:46:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:46:45 INFO - Reading from file tmpfile_stdout 11:46:45 INFO - Output received: 11:46:45 INFO - Usage: mozinstall [options] installer 11:46:45 INFO - Options: 11:46:45 INFO - -h, --help show this help message and exit 11:46:45 INFO - -d DEST, --destination=DEST 11:46:45 INFO - Directory to install application into. [default: 11:46:45 INFO - "/builds/slave/test"] 11:46:45 INFO - --app=APP Application being installed. [default: firefox] 11:46:45 INFO - mkdir: /builds/slave/test/build/application 11:46:45 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'] 11:46:45 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 11:47:04 INFO - Reading from file tmpfile_stdout 11:47:04 INFO - Output received: 11:47:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:47:04 INFO - Running post-action listener: _resource_record_post_action 11:47:04 INFO - [mozharness: 2017-02-06 19:47:04.955057Z] Finished install step (success) 11:47:04 INFO - [mozharness: 2017-02-06 19:47:04.955244Z] Running run-tests step. 11:47:04 INFO - Running pre-action listener: _resource_record_pre_action 11:47:04 INFO - Running main action method: run_tests 11:47:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:47:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:47:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:47:04 INFO - 2017-02-06 11:47:04.969 screenresolution[2158:21388] starting screenresolution argv=screenresolution get 11:47:04 INFO - 2017-02-06 11:47:04.972 screenresolution[2158:21388] Display 0: 1600x1200x32@60 11:47:04 INFO - 2017-02-06 11:47:04.978 screenresolution[2159:21390] starting screenresolution argv=screenresolution list 11:47:04 INFO - Available Modes on Display 0 11:47:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:47:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:47:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:47:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:47:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:47:05 INFO - Intel Iris: 11:47:05 INFO - Chipset Model: Intel Iris 11:47:05 INFO - Type: GPU 11:47:05 INFO - Bus: Built-In 11:47:05 INFO - VRAM (Dynamic, Max): 1536 MB 11:47:05 INFO - Vendor: Intel (0x8086) 11:47:05 INFO - Device ID: 0x0a2e 11:47:05 INFO - Revision ID: 0x0009 11:47:05 INFO - Displays: 11:47:05 INFO - Display: 11:47:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:47:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:47:05 INFO - Display Serial Number: 1600x1200 60 11:47:05 INFO - Main Display: Yes 11:47:05 INFO - Mirror: Off 11:47:05 INFO - Online: Yes 11:47:05 INFO - Rotation: Supported 11:47:05 INFO - Return code: 0 11:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:47:05 INFO - Python 2.7.3 11:47:05 INFO - Return code: 0 11:47:05 INFO - grabbing minidump binary from tooltool 11:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:05 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 0x1045f2d30>, '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 0x104519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:47:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:47:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:47:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:47:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:05 INFO - Return code: 0 11:47:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:47:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:47:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:47:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:47:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:47:05 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/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 11:47:05 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/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 11:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lCOSmp9jf3/Render', 11:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:05 INFO - 'HOME': '/Users/cltbld', 11:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:05 INFO - 'LOGNAME': 'cltbld', 11:47:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:05 INFO - 'MOZ_NO_REMOTE': '1', 11:47:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:05 INFO - 'NO_EM_RESTART': '1', 11:47:05 INFO - 'PAGER': '/bin/cat', 11:47:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:05 INFO - 'PWD': '/builds/slave/test', 11:47:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:05 INFO - 'SHELL': '/bin/bash', 11:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iDzAUDtmLL/Listeners', 11:47:05 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:05 INFO - 'USER': 'cltbld', 11:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:05 INFO - 'XPC_FLAGS': '0x0', 11:47:05 INFO - 'XPC_SERVICE_NAME': '0', 11:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:05 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/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 11:47:05 INFO - mozversion application_buildid: 20170206101454 11:47:05 INFO - mozversion application_changeset: 05fae22830c0365b8173be4a2584ff0375b547a1 11:47:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:47:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:05 INFO - mozversion application_name: Firefox 11:47:05 INFO - mozversion application_remotingname: firefox-dev 11:47:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:47:05 INFO - mozversion application_vendor: Mozilla 11:47:05 INFO - mozversion application_version: 53.0a2 11:47:05 INFO - mozversion platform_buildid: 20170206101454 11:47:05 INFO - mozversion platform_changeset: 05fae22830c0365b8173be4a2584ff0375b547a1 11:47:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:47:05 INFO - mozversion platform_version: 53.0a2 11:47:05 INFO - using testdate: 1486410425 11:47:05 INFO - actual date: 1486410425 11:47:05 INFO - starting webserver on 'localhost:56369' 11:47:05 INFO - SUITE-START | Running 2 tests 11:47:05 INFO - TEST-START | dromaeo_css 11:47:05 INFO - operating with platform_type : mac_ 11:47:05 INFO - Initialising browser for dromaeo_css test... 11:47:05 INFO - TEST-INFO | started process 2169 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmppneEHf/profile http://localhost:56369/getInfo.html) 11:47:08 INFO - PROCESS | 2169 | 2017-02-06 11:47:08.384 plugin-container[2171:21570] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x914f, name = 'com.apple.tsm.portname' 11:47:08 INFO - PROCESS | 2169 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:47:08 INFO - PROCESS | 2169 | 2017-02-06 11:47:08.387 plugin-container[2171:21570] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 11:47:08 INFO - PROCESS | 2169 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:47:08 INFO - PROCESS | 2169 | 2017-02-06 11:47:08.387 plugin-container[2171:21570] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:47:08 INFO - PROCESS | 2169 | __metrics Screen width/height:1600/1200 11:47:08 INFO - PROCESS | 2169 | colorDepth:24 11:47:08 INFO - PROCESS | 2169 | Browser inner width/height: 1024/663 11:47:08 INFO - PROCESS | 2169 | __metrics 11:47:08 ERROR - PROCESS | 2169 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 11:47:08 INFO - PROCESS | 2169 | 1486410428616 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/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmppneEHf/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmppneEHf/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmppneEHf/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmppneEHf/profile/extensions/talos-powers@TalosPowersService.js:55:9 11:47:09 INFO - TEST-INFO | 2169: exit 0 11:47:09 INFO - Browser initialized. 11:47:09 INFO - Running cycle 1/1 for dromaeo_css test... 11:47:09 INFO - TEST-INFO | started process 2172 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmppneEHf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:11 INFO - PROCESS | 2172 | 2017-02-06 11:47:11.718 plugin-container[2173:21703] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 11:47:11 INFO - PROCESS | 2172 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:47:11 INFO - PROCESS | 2172 | 2017-02-06 11:47:11.719 plugin-container[2173:21703] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 11:47:11 INFO - PROCESS | 2172 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:47:11 INFO - PROCESS | 2172 | 2017-02-06 11:47:11.719 plugin-container[2173:21703] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:47:21 INFO - PROCESS | 2172 | RSS: Main: 228446208 11:47:21 INFO - PROCESS | 2172 | 11:50:24 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:56369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56369/tests/dromaeo/cssquery-ext.html) 11:50:25 INFO - PROCESS | 2172 | RSS: Main: 242630656 11:50:25 INFO - PROCESS | 2172 | 11:52:09 INFO - PROCESS | 2172 | ************************* 11:52:09 INFO - PROCESS | 2172 | A coding exception was thrown and uncaught in a Task. 11:52:09 INFO - PROCESS | 2172 | 11:52:09 ERROR - PROCESS | 2172 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:52:09 INFO - PROCESS | 2172 | Full stack: 11:52:09 INFO - PROCESS | 2172 | ************************* 11:53:28 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:56369/tests/dromaeo/cssquery-ext.html (next: http://localhost:56369/tests/dromaeo/cssquery-jquery.html) 11:53:28 INFO - PROCESS | 2172 | RSS: Main: 251305984 11:53:28 INFO - PROCESS | 2172 | 11:56:30 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:56369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56369/tests/dromaeo/cssquery-mootools.html) 11:56:31 INFO - PROCESS | 2172 | RSS: Main: 258060288 11:56:31 INFO - PROCESS | 2172 | 11:59:33 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:56369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56369/tests/dromaeo/cssquery-prototype.html) 11:59:33 INFO - PROCESS | 2172 | RSS: Main: 254459904 11:59:33 INFO - PROCESS | 2172 | 12:02:36 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:56369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56369/tests/dromaeo/cssquery-yui.html) 12:02:37 INFO - PROCESS | 2172 | RSS: Main: 259436544 12:02:37 INFO - PROCESS | 2172 | 12:05:39 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:56369/tests/dromaeo/cssquery-yui.html (next: http://localhost:56369/tests/dromaeo/cssquery-dojo.html) 12:05:40 INFO - PROCESS | 2172 | RSS: Main: 260829184 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | __start_tp_report 12:05:40 INFO - PROCESS | 2172 | _x_x_mozilla_page_load 12:05:40 INFO - PROCESS | 2172 | _x_x_mozilla_page_load_details 12:05:40 INFO - PROCESS | 2172 | |i|pagename|runs| 12:05:40 INFO - PROCESS | 2172 | |0;dojo.html;3343;3353.849076791544;3383.8984830455097;3388.5594872666547;3402.4556071028624;5582.944170558293;5586.329640443148;5623.212750214973;5670.0927851543765;5671.489565939065;5586.944130558693;5646.068398714217;5660.235868157797;5676.914846277299;5718.857028574288;5114.360704911876;5181.1710126379785;5182.663126896739;5185.066687996159;5263.6841789492755;4384.956150438503;4407;5154.07226699194;5255.973720131413;5263.789448422059;4337.544557821415;5104.591632669396;5109.182530795074;5230.398504172012;5275.472452754732;4256.318988961767;5173.767180476888;5182.714950677711;5197.986392653434;5246.134387826004;5080.364954380702;5123.923141152885;5131.666441681316;5133.537981581676;5137.922931155998;5465.289512363367;5607.383187849333;5616.691081990489;5693.516051135658;5701.629394089371;4797.2564252540915;5988.281406231236;6108.633481991051;6154.84612884677;6209.223847019122;6227.875442491125;6240.781572644935;6257.061440783873;6257.124002639634;6268.874622507525;5741.540676745851;5762.510186634099;5778.8266352009505;5786.71066446676;5792.304923409176;6190.071489276645;6210.844728881814;6220.875582488325;6221.253449585988;6269.780557680459;5993;5995.950708625973;6037.78867739627;6049.8487537811025;6080.118382834465;6125.632462052291;6171.6297022178815;6177.722002509898;6191.226096737908;6218.409251121137;6012.7895523657335;6055.6063855849225;6095.481884039907;6104.359042300494;6126.877462450726;6179.62922224668;6190.442860142519;6195.101710251988;6203.751849925952;6208.441240288395;4932.235503496964;4941.851744447672;4944.48082951285;4954.3311652926395;4955.40535135786;4350.260455722535;4351.912961740747;4380.824767009284;4447.955520444754;4474.284114541658;5669.603127781098;5719.628224165416;5762.74067666956;5813.331466881278;5844.766209351664;6195.256569211723;6233.563650544418;6254.499640028786;6258.15514905491;6258.561900667;5658.773649053992;5663.518600918886;5664.405237450091;5681.545476361881;5699.116636921284;5329.813456529003;5332.466753324714;5340.332458442695;5343.866403339947;5368.946310536845;6265.185525881606;6281.685915704105;6284.654344011124;6314.936850631619;6319.778807741707;6111.236095488064;6119.020956646915;6130.386961303834;6166.599171053867;6170.382961703974;6232.283287422005;6243.875122497434;6284.8428789278805;6285.528585356208;6289.150964619901;6064.666443345658;6128.50971922254;6130.325664177026;6130.386961303834;6130.846728831815;6034.185384972972;6046.2139921809885;6166.260048794174;6227.782027629011;6231.937680623317;5991;6024.728887199999;6038.667873266837;6054.878902421839;6058.939410605837;5919.289685237799;5971.641701497924;5976.372480889618;5994.160817485468;6053.697315134137;4737.834175803968;5666.518345940642;5724.742386592697;5897.026990546512;5899.351071382231;5952.434518720715;5968;6027.668478233739;6060.696965151813;6094.878102437838;4826.686265392738;4866.95133048665;5698.572607054404;5883.499902508334;5883.61756485827 12:05:40 INFO - PROCESS | 2172 | |1;ext.html;409.4022726818844;471.19896176499947;488.08727679239826;489.9510048995101;535.7080391186803;38561.228775424475;41440;41485.37771933423;41509.58490415095;41528;42712.78643606778;43077.92305192372;43222;43248.783756081255;43263.56736432635;9210.125038121385;9450.621975120986;9499.525023748785;11055.834162487568;11463.197576169672;11263.66209013731;11331.03686186675;11346.886531134707;11374.71563210918;11392.658220253365;10300.021497957681;10756.354618722862;11338;11374.772504549905;11398.943005284962;10151.035651613085;10906.727331816688;11309.660710178667;11395.601153959571;11404.030657394049;11271;11347.943260283728;11351.829722554168;11374.772504549863;11389.259698119597;38093;38168;38235.80882095572;38377.616223837686;38412.231755365014;3499.965000349989;3850.9229815403814;3922.2547715933883;3954.189391174831;4002.6197511236387;24819.62770558443;27489.037883674177;28129.29676758077;28725.28186795326;29432.55851162234;3149.354382351635;3166.778325517215;3288.8026718396973;3289.7203737682325;3299.472084466498;477884;478438.9999999965;478483;478842;479564;58247.67009319665;58683.11975320373;58805.41194588085;58850.70574647185;58880;60996.69501652463;61392.07911881326;62135;62282.688586556775;62317.37682623207;15750.527484175493;15927.920360398355;15932.522024339289;15947.282372293275;15950.202489875692;11131.499082541304;11402.543898243977;12240.938795305967;12468.875311246771;12488.25070495773;18262;18447.16987735555;18509.7223541647;18525.258989640264;18621.90689046546;8150.551719655476;8229.300509456643;8233.094359620436;8242.629081691339;8284.337253019745;780.6331024418514;782.6772754045645;841.2807049972185;878;895.8118795052982;30281.24296892595;30664.540031899538;30912;31278.06165815029;31431.685683143332;1037.8754549454113;1039.2465462539749;1069.1607088435542;1076.69852441315;1242.67069226655;13659.292588426446;15277.38890444392;16712.665746684997;16818.24317905697;17225.39711110105;638116;638707;640081.799590999;642515.7874210599;643131;65002.349976500576;65209;65898.67050664716;65944.01083983744;66020.66989665022;1294.890352820696;1486.323722706166;1487.5091219897408;1519.3770554072778;1526.5572983834563;29553.26116847096;30615.693843061283;30872.837318573424;31013.379732405676;31058.378832423678;54425;54955.725221373636;55127.89744205013;55224.72387638036;55260.17109743437;571440;573369;576164;579707;580393;43341.783291083346;43995.68012959616;44503.33245001392;44567.88580285519;44722.3291650632;47520.287195692785;47756.5224347766;48000.27999580079;49306.75346623387;49427.50572494229;39696;40041.799791000856;40352.596474034886;40847.774566763044;41524;39382.409263861635;39413.2117357657;39728.40407393949;40554.79722601368;40609.59390406058;38165.618343816204;38318.23363532769;38804.61195388123;39118.80440597779;39131.80434097925;34320.65679343275;34845.825770872;35424;35603.10992225215;35654;25529.74470255348;25685.229443116736;25695.357616059748;25786.484270314864;26252.343691407103 12:05:40 INFO - PROCESS | 2172 | |2;jquery.html;392.46232661254083;393.51990571502756;397.1956787505302;397.6520544523542;419.3918817714313;15676.451324203626;19622.70565941512;20377.08303126359;20921.47696307591;20937.47656308593;21217.787822121772;21231.57536849262;21526.461838454008;21965.23121690741;22302.553948921053;5676.262085928834;5865.149553314767;5891.145783861338;5907.7636894524385;5915.231019967398;5630.436956304357;5773.249477567911;5773.913391299113;5880.794172203974;5885.4997325227405;5777.277840269966;5788.71056447178;5788.97105514474;5790.247267855173;5806.187133801272;5539.086050801613;5539.169124631298;5785.161151633031;5785.334686511042;5788.305403351604;5077.974610126926;5088.745562721849;5088.745562721849;5099.413567439718;5105.336306280197;25545.872270638713;25715.35711607206;25935.481290374086;25970.350741231432;26034.479310413873;2743.1633351827686;2773.4037182005763;2790.9302267443477;2798.818076825;2799.9160025199276;11466.2546934449;11890.643280701594;12977.740445191042;13093.607191784167;14668.753155981754;1729.8060806811754;1828.3874901907743;1828.4331857124334;1838.0717737542589;1873.9718904216447;116112;116726;117587.41206294;118084;118098.77690044936;11575.826362604568;11789.292642441482;11818.231814932002;11864.525418983316;11895.750946150703;13017.674558136123;13957.511487097903;14775.778363324558;14783.70432591342;14783.778243326358;7800.180980997027;8453.239208471266;8644.265237454762;8798.38411311202;8956.104389560991;8684.739457816275;8716.869246961302;8746.781330466789;8789.560521973875;8881.555922203865;7314.890276645855;7440.627968601657;7443.404527637776;7452.701891924371;7463;1918.9136488858035;1946.8442524598;1954.7556555430572;1959.0694420150314;1969.1138987455702;1059.6397224943403;1059.814532456817;1070.9946450267698;1073.1629329123296;1107.5126944144552;22021.66967495489;22094.88952555259;22178.223762168247;22190.445238868833;22200.77799221987;1091.5524634899652;1095.7534554725123;1106.7399161197113;1112.249231768553;1120.383788916093;11260.155488338407;11832.822507662391;12038.578649747393;12046.397680115959;12070.456829442695;736041;749302;752826.2358688172;757777;769524;135667;136004;136262;139354;156360;1039.1323245090434;1057.1331508163387;1084.6312253833735;1085.696005118568;1087.1683162380784;19116.426507204807;19356.70964935499;20169.798302016792;20261.088251029032;20394.980250987093;61674;62639.6868015657;63160.36839631729;63648.68175659092;64173.67913160404;82492.58753706433;83631.5818420904;84472.57763711142;86527.1347286519;87312.1268787304;8239.340852731648;8298.751037468886;8478.660853565789;8590.269827064769;8802.515861627671;12479.93760031194;12843.293618851052;13051.412686428943;13201.669958250737;13279.070465067352;10972.451377431256;11094.833577496183;11150.940660637227;11370.602028928948;11486.425678716198;10773.730656733644;11081.335119892832;11107.777844443228;11256.380899050631;11312.547498099984;11287.661370158909;11438.542458301908;11483.712907177387;11514.654560363202;11867.58463453775;8376.371772116994;8403.70587029451;8457.492550446992;8514.191151840565;8581.742547723577;8731.694390696295;9225.815483690423;10915.235933484897;11113.499892505019;11235.157363197957 12:05:40 INFO - PROCESS | 2172 | |3;mootools.html;1414.2221778022085;1441.9639509012272;1445.2845841308554;1445.4940770730245;1448.7319845828522;6664.700088496017;7452;7702.037245344332;8390.79023024424;8429.873551896726;7948.7217947371855;8127.715529956438;8192.303654189402;8309.418340716153;8357.749267521984;2315.9305220843403;2348.43637526994;2356.611159158737;2356.8468049576722;2357.222116701493;1727.1709579401895;2013.476496111007;2301.0795681727277;2343;2392;2292.64464008079;2328.592496313147;2330.0796185506715;2332.5917964356254;2333.0784340185614;2303.470201853583;2314.618088015475;2321.7330007049236;2334.4397344637164;2340.648902664597;2133.5092928626505;2164.945876353088;2339.801116905065;2350.823688223373;2377.2036367816804;8394.79013024673;8396.034456037572;8440.535770532619;8443.662253509852;8453.070162282143;5146.897062058775;5228.137357336035;5228.241904923802;5235.973820130913;5242.1088414969545;3221.5167724841226;3428.639992800745;3461.7576769626135;3463.1688394785324;3532.487789270567;1177.7232350397649;1196.07304339137;1210.4189988805335;1214.4838443661408;1242.142921384251;10667.733306667318;10688.78622427547;10757.354558726423;10769.78460430787;10810.459477026117;4429.092036132585;4690.460597031317;4743.549362810528;4745.217039188564;4757.024809913959;9474.573644186028;9526.571304291323;9593.13661770444;9595.568199431042;9601.951990240144;5185.870353241199;5242.68543887368;5261.210818377274;5265.6050796189675;5266.97366513165;4322.805473753689;4396.406485124531;4791.544803243756;4827.951720482821;4835.782389792468;3405.8126803025575;3935.626115519021;3959.6238357356006;3976.383660532622;3994.940075898864;1177.9810463948622;1216.2094638484878;1248.818921256431;1282.5639282643947;1285.183908218288;815.5188438821124;880.4497189256715;883.7186080183759;914.154407173362;926.7961048569304;5791.8552036199435;5824.184614154022;5847.9357146063785;5894.440028197314;6066.545009124334;892.3307519360479;984.7439665686973;997.670768646345;1020.2501161646184;1048.5438834107188;3623.691986181204;3677.595464498903;3696.5748938872375;3767.2088861339425;3838.3858582627204;9421.152096311365;9839.901600983898;9843.509123264472;9897.406155630686;9940.602375905028;8299.585020749058;9712.271579631555;9734.318597698235;9800.852987205197;9807.26445516589;7663.6168191590195;7670.539767613961;7750.883736743954;7792.688292468351;7901.565413902175;5378.462153784591;5485.122380419114;5496.780128794803;5545.916811247916;5642.463965923231;9124.31567632417;9149.63401463934;9205.585748641193;9298.674546390845;9302.720918372459;8973.910260897308;9371.531423428665;9380.48407337603;9397.624095036123;9400.858987115336;7017.578945263096;7099.787006389816;7116.359527642537;7136.357727804522;7151.356377926011;7711.730089446843;7732.806679832825;7791.961040194763;7804.492707973964;7841.215878412113;6408.359164083555;6674.9332506676255;6745.831354216184;6760.594364338155;7073.3987611053635;6810.250872404131;6912.723491060301;6931;7047.612381319077;7050.471214658818;6303.527235457267;6381.457576106083;6382.393672601095;6385.233771947396;6407.10300557913;4026.4765580475523;4859.805607775649;4864.246041863516;4961.578265847444;5057.848264552069;4892.584130348961;4985.725785081855;5006.674566153189;5048.091343558195;5051.040302342543 12:05:40 INFO - PROCESS | 2172 | |4;prototype.html;308.64814111912426;322.445811190064;327.3436759297611;349.08887802834596;360.1698085911973;4663.860084197471;4849;5156.685045313449;5352.973235133829;5572.832815015546;4634.443866735988;4750.952490475094;5088.7964481420695;5205.386330237629;5396.325459317585;3271.2803183299634;3712.795796231206;4145.233131870614;4263.87208383749;4266.445362102922;3691.7969511676847;3869.496965394509;4161;4290.54949230331;4291.206126866539;4038.9296836338394;4055.472788537486;4066.715329926906;4072.8370865165357;4074.22589707956;3566.144125409883;4058.634722874926;4062.817173227197;4077.612626800449;4092.015372544314;3540.8583656653705;3547.0600290922926;3553.7690050146916;3560.1989552350774;3574.3744844652083;4132.566080561528;5140.228965655144;5270.9736451317885;5313.495217954288;5329.813456529042;4391.451068616423;4450.709294304648;4661.27315520421;4661.976690116528;4695.577398034159;4339.826406943718;4550.772461376918;4767.713937163747;5644.57665675076;5687.886242275132;3748.7938163401004;3775.207206486614;3868.32304346741;3891.9805400972814;3928.8428462861452;4535.705179163377;5552.111662134039;5641.576881733887;5831.329397119343;6017;3934.350832112669;3945.072907866649;3959.495391751116;3962.6725047108966;3963.781991990468;3593.5446144311595;3617.222297206113;3823.4323927189716;3985.8405663773706;4013.959860401417;4276.593723596254;4631.675782695246;4647.930281045787;4658.906821863544;4724.2205036169335;4833.468318484964;5289.920651190235;5847.298324201038;5857.824265272048;5864.706764661835;1154.4054811771944;1249.5501619417003;1261.5080118753694;1304.7977563477486;1304.8564657887625;696.4150113904344;770.818857568471;809.4333966223667;859.7170387966039;886.3618194899661;4592.7014744041535;4719.560534037083;5277.021117081094;5282.867928301823;5283;4947.604191664658;5441.59188060897;5691.402402747734;5740.598158128974;5754.74103665336;4996.725180115056;5068.57870937116;5200.427952925175;5209.4009188943;5228.163948347763;2835.8865645374367;2964.9258768530526;2980;3047.9542806857917;3051.0389227393744;5602.65536271292;5907.442738560195;5996.2504686914135;6015.488683461867;6023.397660234029;4929.605631549467;5429.19076588047;5464.699441530754;5798.94201057984;5869.735861886225;4933.038057578881;5190.4445454863535;5195.376554813447;5364.81973965727;5426.403095659474;4847.660663753503;5023;5232.389651140701;5515.751791169488;5795.145553423033;5198.818041368534;5209.76556054986;5249.482846492935;5365.973170134124;5381.627684940315;4743.343727512604;5314;5561.721913904369;5816.680082595498;6008.729607167776;3531.0819187011048;3683.50272713191;3768.1521657626813;3785.280796648738;3789.261094086737;5368.40947495783;5586.497215250484;5600;5651.463111004448;5714.285714285715;4927.457979622311;5550.611457197957;5580.888382232414;5773.278340207474;5784.768609255582;4773.76131193432;5709.457601527848;5733.942660573341;5755.5971082025535;5760.308762948473;4977.4524802271;5133.79464821403;5462.825492519128;5653.201665175764;5681.829545113653;4629.814807407666;5476.753546090516;5640.012997725464;5699.6580205186165;5756.71216439168;5157.896842063213;5615.887682246251;5617.74720137603;5639.210510528447;5643.830685079454 12:05:40 INFO - PROCESS | 2172 | |5;yui.html;679.6160169504233;681.567204824936;757.7310054930499;821.8602837517622;828.954407507587;11878.643640690772;12310.322932238723;14850.851491485082;14862.405503779863;14907.403703851847;14343.856561434382;14531.92734036331;14559.126452412862;14561.271936403191;14562.199079050648;668.5587512241922;688.8553403785186;835.4360806455618;854.2738672128672;857.9742607721778;858.4977787994031;870.8998465176522;872.2890843962182;872.4242000279817;875.8379699755566;784.1883650421814;925.6112432778249;926.6710317837172;928.4475736936546;929.7117893453018;918.779492921694;925.8379783537888;926.2543652359848;926.6247169896203;931.5388882503204;681.0567364200568;689.4622194688101;690.3579670906055;690.4579904774778;690.7547820523693;14766.187859667714;15127.54617361481;15129.319180636898;15448.073115613099;15552;11848.28910265387;11984.280943143352;12006.69983250417;12157;12364.763523647653;11301.755680288737;11707.414629268587;11716.648500544998;11800;12072.818907716392;3734.1224812169116;3786.053486628343;3789.8673546426016;3858.1704933439164;3901.395283731026;95944.52027739887;96386;96625;97114.51442742882;97707;10955.287906286225;11027.61403350895;11046.944765276123;11116.888831111748;11213.21507494484;22432.66351004736;22800.087996480288;22836.88581557115;22849;22856.428589285068;7783.494072885244;7805.297523222937;7836.216378362232;7903.565303908225;8028.197180282042;4193.51774545925;4231.196072746168;4288.078063216361;4296.3555466680245;4300.225959327288;3433.656634336546;3475.913102172466;3486.564179477565;3524.277523107808;3529.1177205698577;614.8555089553952;619.102301662582;624.8531595075153;636.1539152926597;646.0277282689523;681.4480270980522;697.2012208502052;698.0855079845419;717.3651318582987;736.3005145112057;9674.274429417821;9791.314607977516;9913.950430247802;10376.948115259376;10403;688.8997923388423;704.9718011279595;705.7776800307887;708.6881772020295;721.7257442171941;4871.732054737024;4972.328735620645;4988.55103040728;5007.6494645375205;5008.699478031257;106489;107784.46107769411;111292;111761.44119279351;112905;92362;93762;95759;97441;97819.02180978241;63457.365426345146;84083.57958210292;84287;84649.57675211708;85761;10271.845922311022;10966.451677415938;11079.50142243585;11107.278026928223;11144.164187685794;41650.58349416467;42456;47251.109955601394;50694.493055068975;51510.85859715526;57183;60798;65688.67155664192;67251;67432;10945.726356841144;11176.608818691308;11339.829902551633;13134.408951597392;13589.252591107585;14762.557123286319;14883.404663813326;14975.700485990437;15298.770518442456;15363.846361536242;13567.72864542684;14178.645533861736;14249.786253206417;14304.213268270345;14457.204853732725;13534.93232533831;13776.24230667323;13844.584662460142;13938.30308484592;14149.575512734635;12893.677658058248;13100.541481048118;13538.187708737507;13975.694010488156;14066.085704429179;9186.632534698538;10747.301425407324;11428.94285528567;11439.942800286279;11557.30656160633;9603.423794572349;9668.85496717564;10753.649091450638;10960.725981850517;10966.342019478856 12:05:40 INFO - PROCESS | 2172 | __end_tp_report 12:05:40 INFO - PROCESS | 2172 | __start_cc_report 12:05:40 INFO - PROCESS | 2172 | _x_x_mozilla_cycle_collect,376 12:05:40 INFO - PROCESS | 2172 | __end_cc_report 12:05:40 INFO - PROCESS | 2172 | __startTimestamp1486411540207__endTimestamp 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | ------- Summary: start ------- 12:05:40 INFO - PROCESS | 2172 | Number of tests: 6 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | [#0] dojo.html Cycles:165 Average:5650.19 Median:5883.50 stddev:661.16 (11.2%) stddev-sans-first:637.93 12:05:40 INFO - PROCESS | 2172 | Values: 3343.0 3353.8 3383.9 3388.6 3402.5 5582.9 5586.3 5623.2 5670.1 5671.5 5586.9 5646.1 5660.2 5676.9 5718.9 5114.4 5181.2 5182.7 5185.1 5263.7 4385.0 4407.0 5154.1 5256.0 5263.8 4337.5 5104.6 5109.2 5230.4 5275.5 4256.3 5173.8 5182.7 5198.0 5246.1 5080.4 5123.9 5131.7 5133.5 5137.9 5465.3 5607.4 5616.7 5693.5 5701.6 4797.3 5988.3 6108.6 6154.8 6209.2 6227.9 6240.8 6257.1 6257.1 6268.9 5741.5 5762.5 5778.8 5786.7 5792.3 6190.1 6210.8 6220.9 6221.3 6269.8 5993.0 5996.0 6037.8 6049.8 6080.1 6125.6 6171.6 6177.7 6191.2 6218.4 6012.8 6055.6 6095.5 6104.4 6126.9 6179.6 6190.4 6195.1 6203.8 6208.4 4932.2 4941.9 4944.5 4954.3 4955.4 4350.3 4351.9 4380.8 4448.0 4474.3 5669.6 5719.6 5762.7 5813.3 5844.8 6195.3 6233.6 6254.5 6258.2 6258.6 5658.8 5663.5 5664.4 5681.5 5699.1 5329.8 5332.5 5340.3 5343.9 5368.9 6265.2 6281.7 6284.7 6314.9 6319.8 6111.2 6119.0 6130.4 6166.6 6170.4 6232.3 6243.9 6284.8 6285.5 6289.2 6064.7 6128.5 6130.3 6130.4 6130.8 6034.2 6046.2 6166.3 6227.8 6231.9 5991.0 6024.7 6038.7 6054.9 6058.9 5919.3 5971.6 5976.4 5994.2 6053.7 4737.8 5666.5 5724.7 5897.0 5899.4 5952.4 5968.0 6027.7 6060.7 6094.9 4826.7 4867.0 5698.6 5883.5 5883.6 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | [#1] ext.html Cycles:180 Average:71030.07 Median:21206.08 stddev:151772.76 (715.7%) stddev-sans-first:152105.90 12:05:40 INFO - PROCESS | 2172 | Values: 409.4 471.2 488.1 490.0 535.7 38561.2 41440.0 41485.4 41509.6 41528.0 42712.8 43077.9 43222.0 43248.8 43263.6 9210.1 9450.6 9499.5 11055.8 11463.2 11263.7 11331.0 11346.9 11374.7 11392.7 10300.0 10756.4 11338.0 11374.8 11398.9 10151.0 10906.7 11309.7 11395.6 11404.0 11271.0 11347.9 11351.8 11374.8 11389.3 38093.0 38168.0 38235.8 38377.6 38412.2 3500.0 3850.9 3922.3 3954.2 4002.6 24819.6 27489.0 28129.3 28725.3 29432.6 3149.4 3166.8 3288.8 3289.7 3299.5 477884.0 478439.0 478483.0 478842.0 479564.0 58247.7 58683.1 58805.4 58850.7 58880.0 60996.7 61392.1 62135.0 62282.7 62317.4 15750.5 15927.9 15932.5 15947.3 15950.2 11131.5 11402.5 12240.9 12468.9 12488.3 18262.0 18447.2 18509.7 18525.3 18621.9 8150.6 8229.3 8233.1 8242.6 8284.3 780.6 782.7 841.3 878.0 895.8 30281.2 30664.5 30912.0 31278.1 31431.7 1037.9 1039.2 1069.2 1076.7 1242.7 13659.3 15277.4 16712.7 16818.2 17225.4 638116.0 638707.0 640081.8 642515.8 643131.0 65002.3 65209.0 65898.7 65944.0 66020.7 1294.9 1486.3 1487.5 1519.4 1526.6 29553.3 30615.7 30872.8 31013.4 31058.4 54425.0 54955.7 55127.9 55224.7 55260.2 571440.0 573369.0 576164.0 579707.0 580393.0 43341.8 43995.7 44503.3 44567.9 44722.3 47520.3 47756.5 48000.3 49306.8 49427.5 39696.0 40041.8 40352.6 40847.8 41524.0 39382.4 39413.2 39728.4 40554.8 40609.6 38165.6 38318.2 38804.6 39118.8 39131.8 34320.7 34845.8 35424.0 35603.1 35654.0 25529.7 25685.2 25695.4 25786.5 26252.3 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | [#2] jquery.html Cycles:180 Average:40442.72 Median:21745.85 stddev:124784.12 (573.8%) stddev-sans-first:125097.93 12:05:40 INFO - PROCESS | 2172 | Values: 392.5 393.5 397.2 397.7 419.4 15676.5 19622.7 20377.1 20921.5 20937.5 21217.8 21231.6 21526.5 21965.2 22302.6 5676.3 5865.1 5891.1 5907.8 5915.2 5630.4 5773.2 5773.9 5880.8 5885.5 5777.3 5788.7 5789.0 5790.2 5806.2 5539.1 5539.2 5785.2 5785.3 5788.3 5078.0 5088.7 5088.7 5099.4 5105.3 25545.9 25715.4 25935.5 25970.4 26034.5 2743.2 2773.4 2790.9 2798.8 2799.9 11466.3 11890.6 12977.7 13093.6 14668.8 1729.8 1828.4 1828.4 1838.1 1874.0 116112.0 116726.0 117587.4 118084.0 118098.8 11575.8 11789.3 11818.2 11864.5 11895.8 13017.7 13957.5 14775.8 14783.7 14783.8 7800.2 8453.2 8644.3 8798.4 8956.1 8684.7 8716.9 8746.8 8789.6 8881.6 7314.9 7440.6 7443.4 7452.7 7463.0 1918.9 1946.8 1954.8 1959.1 1969.1 1059.6 1059.8 1071.0 1073.2 1107.5 22021.7 22094.9 22178.2 22190.4 22200.8 1091.6 1095.8 1106.7 1112.2 1120.4 11260.2 11832.8 12038.6 12046.4 12070.5 736041.0 749302.0 752826.2 757777.0 769524.0 135667.0 136004.0 136262.0 139354.0 156360.0 1039.1 1057.1 1084.6 1085.7 1087.2 19116.4 19356.7 20169.8 20261.1 20395.0 61674.0 62639.7 63160.4 63648.7 64173.7 82492.6 83631.6 84472.6 86527.1 87312.1 8239.3 8298.8 8478.7 8590.3 8802.5 12479.9 12843.3 13051.4 13201.7 13279.1 10972.5 11094.8 11150.9 11370.6 11486.4 10773.7 11081.3 11107.8 11256.4 11312.5 11287.7 11438.5 11483.7 11514.7 11867.6 8376.4 8403.7 8457.5 8514.2 8581.7 8731.7 9225.8 10915.2 11113.5 11235.2 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | [#3] mootools.html Cycles:180 Average:5394.59 Median:5266.29 stddev:2915.93 (55.4%) stddev-sans-first:2908.76 12:05:40 INFO - PROCESS | 2172 | Values: 1414.2 1442.0 1445.3 1445.5 1448.7 6664.7 7452.0 7702.0 8390.8 8429.9 7948.7 8127.7 8192.3 8309.4 8357.7 2315.9 2348.4 2356.6 2356.8 2357.2 1727.2 2013.5 2301.1 2343.0 2392.0 2292.6 2328.6 2330.1 2332.6 2333.1 2303.5 2314.6 2321.7 2334.4 2340.6 2133.5 2164.9 2339.8 2350.8 2377.2 8394.8 8396.0 8440.5 8443.7 8453.1 5146.9 5228.1 5228.2 5236.0 5242.1 3221.5 3428.6 3461.8 3463.2 3532.5 1177.7 1196.1 1210.4 1214.5 1242.1 10667.7 10688.8 10757.4 10769.8 10810.5 4429.1 4690.5 4743.5 4745.2 4757.0 9474.6 9526.6 9593.1 9595.6 9602.0 5185.9 5242.7 5261.2 5265.6 5267.0 4322.8 4396.4 4791.5 4828.0 4835.8 3405.8 3935.6 3959.6 3976.4 3994.9 1178.0 1216.2 1248.8 1282.6 1285.2 815.5 880.4 883.7 914.2 926.8 5791.9 5824.2 5847.9 5894.4 6066.5 892.3 984.7 997.7 1020.3 1048.5 3623.7 3677.6 3696.6 3767.2 3838.4 9421.2 9839.9 9843.5 9897.4 9940.6 8299.6 9712.3 9734.3 9800.9 9807.3 7663.6 7670.5 7750.9 7792.7 7901.6 5378.5 5485.1 5496.8 5545.9 5642.5 9124.3 9149.6 9205.6 9298.7 9302.7 8973.9 9371.5 9380.5 9397.6 9400.9 7017.6 7099.8 7116.4 7136.4 7151.4 7711.7 7732.8 7792.0 7804.5 7841.2 6408.4 6674.9 6745.8 6760.6 7073.4 6810.3 6912.7 6931.0 7047.6 7050.5 6303.5 6381.5 6382.4 6385.2 6407.1 4026.5 4859.8 4864.2 4961.6 5057.8 4892.6 4985.7 5006.7 5048.1 5051.0 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | [#4] prototype.html Cycles:180 Average:4500.80 Median:4987.09 stddev:1369.04 (27.5%) stddev-sans-first:1336.24 12:05:40 INFO - PROCESS | 2172 | Values: 308.6 322.4 327.3 349.1 360.2 4663.9 4849.0 5156.7 5353.0 5572.8 4634.4 4751.0 5088.8 5205.4 5396.3 3271.3 3712.8 4145.2 4263.9 4266.4 3691.8 3869.5 4161.0 4290.5 4291.2 4038.9 4055.5 4066.7 4072.8 4074.2 3566.1 4058.6 4062.8 4077.6 4092.0 3540.9 3547.1 3553.8 3560.2 3574.4 4132.6 5140.2 5271.0 5313.5 5329.8 4391.5 4450.7 4661.3 4662.0 4695.6 4339.8 4550.8 4767.7 5644.6 5687.9 3748.8 3775.2 3868.3 3892.0 3928.8 4535.7 5552.1 5641.6 5831.3 6017.0 3934.4 3945.1 3959.5 3962.7 3963.8 3593.5 3617.2 3823.4 3985.8 4014.0 4276.6 4631.7 4647.9 4658.9 4724.2 4833.5 5289.9 5847.3 5857.8 5864.7 1154.4 1249.6 1261.5 1304.8 1304.9 696.4 770.8 809.4 859.7 886.4 4592.7 4719.6 5277.0 5282.9 5283.0 4947.6 5441.6 5691.4 5740.6 5754.7 4996.7 5068.6 5200.4 5209.4 5228.2 2835.9 2964.9 2980.0 3048.0 3051.0 5602.7 5907.4 5996.3 6015.5 6023.4 4929.6 5429.2 5464.7 5798.9 5869.7 4933.0 5190.4 5195.4 5364.8 5426.4 4847.7 5023.0 5232.4 5515.8 5795.1 5198.8 5209.8 5249.5 5366.0 5381.6 4743.3 5314.0 5561.7 5816.7 6008.7 3531.1 3683.5 3768.2 3785.3 3789.3 5368.4 5586.5 5600.0 5651.5 5714.3 4927.5 5550.6 5580.9 5773.3 5784.8 4773.8 5709.5 5733.9 5755.6 5760.3 4977.5 5133.8 5462.8 5653.2 5681.8 4629.8 5476.8 5640.0 5699.7 5756.7 5157.9 5615.9 5617.7 5639.2 5643.8 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - PROCESS | 2172 | [#5] yui.html Cycles:180 Average:20453.92 Median:4212.36 stddev:29630.12 (703.4%) stddev-sans-first:29676.04 12:05:40 INFO - PROCESS | 2172 | Values: 679.6 681.6 757.7 821.9 829.0 11878.6 12310.3 14850.9 14862.4 14907.4 14343.9 14531.9 14559.1 14561.3 14562.2 668.6 688.9 835.4 854.3 858.0 858.5 870.9 872.3 872.4 875.8 784.2 925.6 926.7 928.4 929.7 918.8 925.8 926.3 926.6 931.5 681.1 689.5 690.4 690.5 690.8 14766.2 15127.5 15129.3 15448.1 15552.0 11848.3 11984.3 12006.7 12157.0 12364.8 11301.8 11707.4 11716.6 11800.0 12072.8 3734.1 3786.1 3789.9 3858.2 3901.4 95944.5 96386.0 96625.0 97114.5 97707.0 10955.3 11027.6 11046.9 11116.9 11213.2 22432.7 22800.1 22836.9 22849.0 22856.4 7783.5 7805.3 7836.2 7903.6 8028.2 4193.5 4231.2 4288.1 4296.4 4300.2 3433.7 3475.9 3486.6 3524.3 3529.1 614.9 619.1 624.9 636.2 646.0 681.4 697.2 698.1 717.4 736.3 9674.3 9791.3 9914.0 10376.9 10403.0 688.9 705.0 705.8 708.7 721.7 4871.7 4972.3 4988.6 5007.6 5008.7 106489.0 107784.5 111292.0 111761.4 112905.0 92362.0 93762.0 95759.0 97441.0 97819.0 63457.4 84083.6 84287.0 84649.6 85761.0 10271.8 10966.5 11079.5 11107.3 11144.2 41650.6 42456.0 47251.1 50694.5 51510.9 57183.0 60798.0 65688.7 67251.0 67432.0 10945.7 11176.6 11339.8 13134.4 13589.3 14762.6 14883.4 14975.7 15298.8 15363.8 13567.7 14178.6 14249.8 14304.2 14457.2 13534.9 13776.2 13844.6 13938.3 14149.6 12893.7 13100.5 13538.2 13975.7 14066.1 9186.6 10747.3 11428.9 11439.9 11557.3 9603.4 9668.9 10753.6 10960.7 10966.3 12:05:40 INFO - PROCESS | 2172 | -------- Summary: end -------- 12:05:40 INFO - PROCESS | 2172 | 12:05:40 INFO - TEST-INFO | 2172: exit 0 12:05:40 INFO - TEST-OK | dromaeo_css | took 1115283ms 12:05:40 INFO - TEST-START | kraken 12:05:40 INFO - operating with platform_type : mac_ 12:05:40 INFO - Initialising browser for kraken test... 12:05:40 INFO - TEST-INFO | started process 2178 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp8H0Ww4/profile http://localhost:56369/getInfo.html) 12:05:43 INFO - PROCESS | 2178 | 2017-02-06 12:05:43.667 plugin-container[2179:23568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 12:05:43 INFO - PROCESS | 2178 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:05:43 INFO - PROCESS | 2178 | 2017-02-06 12:05:43.669 plugin-container[2179:23568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 12:05:43 INFO - PROCESS | 2178 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:05:43 INFO - PROCESS | 2178 | 2017-02-06 12:05:43.669 plugin-container[2179:23568] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:05:43 INFO - PROCESS | 2178 | __metrics Screen width/height:1600/1200 12:05:43 INFO - PROCESS | 2178 | colorDepth:24 12:05:43 INFO - PROCESS | 2178 | Browser inner width/height: 1024/663 12:05:43 INFO - PROCESS | 2178 | __metrics 12:05:43 ERROR - PROCESS | 2178 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 12:05:43 INFO - PROCESS | 2178 | 1486411543867 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/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp8H0Ww4/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp8H0Ww4/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp8H0Ww4/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp8H0Ww4/profile/extensions/talos-powers@TalosPowersService.js:55:9 12:05:44 INFO - TEST-INFO | 2178: exit 0 12:05:44 INFO - Browser initialized. 12:05:44 INFO - Running cycle 1/1 for kraken test... 12:05:44 INFO - TEST-INFO | started process 2180 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp8H0Ww4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:05:47 INFO - PROCESS | 2180 | 2017-02-06 12:05:47.161 plugin-container[2181:23700] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 12:05:47 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:05:47 INFO - PROCESS | 2180 | 2017-02-06 12:05:47.161 plugin-container[2181:23700] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 12:05:47 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:05:47 INFO - PROCESS | 2180 | 2017-02-06 12:05:47.161 plugin-container[2181:23700] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:05:56 INFO - PROCESS | 2180 | RSS: Main: 228298752 12:05:56 INFO - PROCESS | 2180 | 12:05:59 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56369/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:00 INFO - PROCESS | 2180 | RSS: Main: 240009216 12:06:00 INFO - PROCESS | 2180 | 12:06:03 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56369/tests/kraken/driver.html?testName=audio-dft) 12:06:04 INFO - PROCESS | 2180 | RSS: Main: 247963648 12:06:04 INFO - PROCESS | 2180 | 12:06:07 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56369/tests/kraken/driver.html?testName=audio-fft) 12:06:08 INFO - PROCESS | 2180 | RSS: Main: 250224640 12:06:08 INFO - PROCESS | 2180 | 12:06:09 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56369/tests/kraken/driver.html?testName=audio-oscillator) 12:06:10 INFO - PROCESS | 2180 | RSS: Main: 249995264 12:06:10 INFO - PROCESS | 2180 | 12:06:12 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:06:13 INFO - PROCESS | 2180 | RSS: Main: 250023936 12:06:13 INFO - PROCESS | 2180 | 12:06:16 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56369/tests/kraken/driver.html?testName=imaging-darkroom) 12:06:16 INFO - PROCESS | 2180 | RSS: Main: 254586880 12:06:16 INFO - PROCESS | 2180 | 12:06:20 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56369/tests/kraken/driver.html?testName=imaging-desaturate) 12:06:20 INFO - PROCESS | 2180 | RSS: Main: 253374464 12:06:20 INFO - PROCESS | 2180 | 12:06:23 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56369/tests/kraken/driver.html?testName=json-parse-financial) 12:06:24 INFO - PROCESS | 2180 | RSS: Main: 253321216 12:06:24 INFO - PROCESS | 2180 | 12:06:25 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:06:26 INFO - PROCESS | 2180 | RSS: Main: 252723200 12:06:26 INFO - PROCESS | 2180 | 12:06:28 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:06:29 INFO - PROCESS | 2180 | RSS: Main: 252715008 12:06:29 INFO - PROCESS | 2180 | 12:06:31 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:06:31 INFO - PROCESS | 2180 | RSS: Main: 252674048 12:06:31 INFO - PROCESS | 2180 | 12:06:34 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:06:35 INFO - PROCESS | 2180 | RSS: Main: 253124608 12:06:35 INFO - PROCESS | 2180 | 12:06:38 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:06:39 INFO - PROCESS | 2180 | RSS: Main: 253116416 12:06:39 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:56369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56369/tests/kraken/driver.html?testName=ai-astar) 12:06:41 INFO - PROCESS | 2180 | RSS: Main: 254980096 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | __start_tp_report 12:06:41 INFO - PROCESS | 2180 | _x_x_mozilla_page_load 12:06:41 INFO - PROCESS | 2180 | _x_x_mozilla_page_load_details 12:06:41 INFO - PROCESS | 2180 | |i|pagename|runs| 12:06:41 INFO - PROCESS | 2180 | |0;ai-astar;109;118;119;118;118;116;119;119;118;119 12:06:41 INFO - PROCESS | 2180 | |1;audio-beat-detection;148;117;115;149;106;155;147;148;135;117 12:06:41 INFO - PROCESS | 2180 | |2;audio-dft;200;199;199;200;198;195;201;196;200;200 12:06:41 INFO - PROCESS | 2180 | |3;audio-fft;84;61;60;89;67;69;51;65;84;83 12:06:41 INFO - PROCESS | 2180 | |4;audio-oscillator;86;70;70;90;85;100;115;103;63;103 12:06:41 INFO - PROCESS | 2180 | |5;imaging-gaussian-blur;116;86;88;87;91;95;89;89;130;120 12:06:41 INFO - PROCESS | 2180 | |6;imaging-darkroom;99;101;105;99;121;99;152;170;118;168 12:06:41 INFO - PROCESS | 2180 | |7;imaging-desaturate;92;98;93;92;95;93;92;96;93;92 12:06:41 INFO - PROCESS | 2180 | |8;json-parse-financial;62;65;63;61;64;64;64;77;91;97 12:06:41 INFO - PROCESS | 2180 | |9;json-stringify-tinderbox;69;74;67;83;81;75;70;71;73;74 12:06:41 INFO - PROCESS | 2180 | |10;stanford-crypto-aes;105;87;88;85;84;86;87;87;84;86 12:06:41 INFO - PROCESS | 2180 | |11;stanford-crypto-ccm;143;146;155;148;153;145;144;144;236;141 12:06:41 INFO - PROCESS | 2180 | |12;stanford-crypto-pbkdf2;177;172;171;170;214;160;219;228;170;227 12:06:41 INFO - PROCESS | 2180 | |13;stanford-crypto-sha256-iterative;62;77;86;85;74;68;67;68;65;67 12:06:41 INFO - PROCESS | 2180 | __end_tp_report 12:06:41 INFO - PROCESS | 2180 | __start_cc_report 12:06:41 INFO - PROCESS | 2180 | _x_x_mozilla_cycle_collect,952 12:06:41 INFO - PROCESS | 2180 | __end_cc_report 12:06:41 INFO - PROCESS | 2180 | __startTimestamp1486411601393__endTimestamp 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | ------- Summary: start ------- 12:06:41 INFO - PROCESS | 2180 | Number of tests: 14 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#0] ai-astar Cycles:10 Average:117.30 Median:118.50 stddev:3.06 (2.6%) stddev-sans-first:0.97 12:06:41 INFO - PROCESS | 2180 | Values: 109.0 118.0 119.0 118.0 118.0 116.0 119.0 119.0 118.0 119.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:147.50 stddev:18.10 (12.3%) stddev-sans-first:18.45 12:06:41 INFO - PROCESS | 2180 | Values: 148.0 117.0 115.0 149.0 106.0 155.0 147.0 148.0 135.0 117.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#2] audio-dft Cycles:10 Average:198.80 Median:200.00 stddev:1.93 (1.0%) stddev-sans-first:2.00 12:06:41 INFO - PROCESS | 2180 | Values: 200.0 199.0 199.0 200.0 198.0 195.0 201.0 196.0 200.0 200.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#3] audio-fft Cycles:10 Average:71.30 Median:76.00 stddev:12.83 (16.9%) stddev-sans-first:12.76 12:06:41 INFO - PROCESS | 2180 | Values: 84.0 61.0 60.0 89.0 67.0 69.0 51.0 65.0 84.0 83.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:70.00 stddev:17.03 (24.3%) stddev-sans-first:18.04 12:06:41 INFO - PROCESS | 2180 | Values: 86.0 70.0 70.0 90.0 85.0 100.0 115.0 103.0 63.0 103.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#5] imaging-gaussian-blur Cycles:10 Average:99.10 Median:88.50 stddev:16.35 (18.5%) stddev-sans-first:16.15 12:06:41 INFO - PROCESS | 2180 | Values: 116.0 86.0 88.0 87.0 91.0 95.0 89.0 89.0 130.0 120.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#6] imaging-darkroom Cycles:10 Average:123.20 Median:169.00 stddev:29.13 (17.2%) stddev-sans-first:29.56 12:06:41 INFO - PROCESS | 2180 | Values: 99.0 101.0 105.0 99.0 121.0 99.0 152.0 170.0 118.0 168.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:93.00 stddev:2.07 (2.2%) stddev-sans-first:2.11 12:06:41 INFO - PROCESS | 2180 | Values: 92.0 98.0 93.0 92.0 95.0 93.0 92.0 96.0 93.0 92.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#8] json-parse-financial Cycles:10 Average:70.80 Median:64.50 stddev:13.08 (20.3%) stddev-sans-first:13.48 12:06:41 INFO - PROCESS | 2180 | Values: 62.0 65.0 63.0 61.0 64.0 64.0 64.0 77.0 91.0 97.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:74.00 stddev:5.06 (6.8%) stddev-sans-first:5.07 12:06:41 INFO - PROCESS | 2180 | Values: 69.0 74.0 67.0 83.0 81.0 75.0 70.0 71.0 73.0 74.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:86.50 stddev:6.15 (7.1%) stddev-sans-first:1.41 12:06:41 INFO - PROCESS | 2180 | Values: 105.0 87.0 88.0 85.0 84.0 86.0 87.0 87.0 84.0 86.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#11] stanford-crypto-ccm Cycles:10 Average:155.50 Median:147.00 stddev:28.62 (19.5%) stddev-sans-first:30.00 12:06:41 INFO - PROCESS | 2180 | Values: 143.0 146.0 155.0 148.0 153.0 145.0 144.0 144.0 236.0 141.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.80 Median:195.50 stddev:27.44 (14.0%) stddev-sans-first:28.65 12:06:41 INFO - PROCESS | 2180 | Values: 177.0 172.0 171.0 170.0 214.0 160.0 219.0 228.0 170.0 227.0 12:06:41 INFO - PROCESS | 2180 | 12:06:41 INFO - PROCESS | 2180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.00 stddev:8.33 (11.7%) stddev-sans-first:8.03 12:06:41 INFO - PROCESS | 2180 | Values: 62.0 77.0 86.0 85.0 74.0 68.0 67.0 68.0 65.0 67.0 12:06:41 INFO - PROCESS | 2180 | -------- Summary: end -------- 12:06:41 INFO - PROCESS | 2180 | 12:06:42 INFO - TEST-INFO | 2180: exit 0 12:06:42 INFO - TEST-OK | kraken | took 61543ms 12:06:42 INFO - SUITE-END | took 1176s 12:06:42 INFO - Completed test suite (00:19:36) 12:06:42 INFO - javascript benchmark 12:06:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7362.14033102054, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.0, 3353.849076791544, 3383.8984830455097, 3388.5594872666547, 3402.4556071028624, 5582.944170558293, 5586.329640443148, 5623.212750214973, 5670.0927851543765, 5671.489565939065, 5586.944130558693, 5646.068398714217, 5660.235868157797, 5676.914846277299, 5718.857028574288, 5114.360704911876, 5181.1710126379785, 5182.663126896739, 5185.066687996159, 5263.6841789492755, 4384.956150438503, 4407.0, 5154.07226699194, 5255.973720131413, 5263.789448422059, 4337.544557821415, 5104.591632669396, 5109.182530795074, 5230.398504172012, 5275.472452754732, 4256.318988961767, 5173.767180476888, 5182.714950677711, 5197.986392653434, 5246.134387826004, 5080.364954380702, 5123.923141152885, 5131.666441681316, 5133.537981581676, 5137.922931155998, 5465.289512363367, 5607.383187849333, 5616.691081990489, 5693.516051135658, 5701.629394089371, 4797.2564252540915, 5988.281406231236, 6108.633481991051, 6154.84612884677, 6209.223847019122, 6227.875442491125, 6240.781572644935, 6257.061440783873, 6257.124002639634, 6268.874622507525, 5741.540676745851, 5762.510186634099, 5778.8266352009505, 5786.71066446676, 5792.304923409176, 6190.071489276645, 6210.844728881814, 6220.875582488325, 6221.253449585988, 6269.780557680459, 5993.0, 5995.950708625973, 6037.78867739627, 6049.8487537811025, 6080.118382834465, 6125.632462052291, 6171.6297022178815, 6177.722002509898, 6191.226096737908, 6218.409251121137, 6012.7895523657335, 6055.6063855849225, 6095.481884039907, 6104.359042300494, 6126.877462450726, 6179.62922224668, 6190.442860142519, 6195.101710251988, 6203.751849925952, 6208.441240288395, 4932.235503496964, 4941.851744447672, 4944.48082951285, 4954.3311652926395, 4955.40535135786, 4350.260455722535, 4351.912961740747, 4380.824767009284, 4447.955520444754, 4474.284114541658, 5669.603127781098, 5719.628224165416, 5762.74067666956, 5813.331466881278, 5844.766209351664, 6195.256569211723, 6233.563650544418, 6254.499640028786, 6258.15514905491, 6258.561900667, 5658.773649053992, 5663.518600918886, 5664.405237450091, 5681.545476361881, 5699.116636921284, 5329.813456529003, 5332.466753324714, 5340.332458442695, 5343.866403339947, 5368.946310536845, 6265.185525881606, 6281.685915704105, 6284.654344011124, 6314.936850631619, 6319.778807741707, 6111.236095488064, 6119.020956646915, 6130.386961303834, 6166.599171053867, 6170.382961703974, 6232.283287422005, 6243.875122497434, 6284.8428789278805, 6285.528585356208, 6289.150964619901, 6064.666443345658, 6128.50971922254, 6130.325664177026, 6130.386961303834, 6130.846728831815, 6034.185384972972, 6046.2139921809885, 6166.260048794174, 6227.782027629011, 6231.937680623317, 5991.0, 6024.728887199999, 6038.667873266837, 6054.878902421839, 6058.939410605837, 5919.289685237799, 5971.641701497924, 5976.372480889618, 5994.160817485468, 6053.697315134137, 4737.834175803968, 5666.518345940642, 5724.742386592697, 5897.026990546512, 5899.351071382231, 5952.434518720715, 5968.0, 6027.668478233739, 6060.696965151813, 6094.878102437838, 4826.686265392738, 4866.95133048665, 5698.572607054404, 5883.499902508334, 5883.61756485827], "value": 5608.949476859295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.4022726818844, 471.19896176499947, 488.08727679239826, 489.9510048995101, 535.7080391186803, 38561.228775424475, 41440.0, 41485.37771933423, 41509.58490415095, 41528.0, 42712.78643606778, 43077.92305192372, 43222.0, 43248.783756081255, 43263.56736432635, 9210.125038121385, 9450.621975120986, 9499.525023748785, 11055.834162487568, 11463.197576169672, 11263.66209013731, 11331.03686186675, 11346.886531134707, 11374.71563210918, 11392.658220253365, 10300.021497957681, 10756.354618722862, 11338.0, 11374.772504549905, 11398.943005284962, 10151.035651613085, 10906.727331816688, 11309.660710178667, 11395.601153959571, 11404.030657394049, 11271.0, 11347.943260283728, 11351.829722554168, 11374.772504549863, 11389.259698119597, 38093.0, 38168.0, 38235.80882095572, 38377.616223837686, 38412.231755365014, 3499.965000349989, 3850.9229815403814, 3922.2547715933883, 3954.189391174831, 4002.6197511236387, 24819.62770558443, 27489.037883674177, 28129.29676758077, 28725.28186795326, 29432.55851162234, 3149.354382351635, 3166.778325517215, 3288.8026718396973, 3289.7203737682325, 3299.472084466498, 477884.0, 478438.9999999965, 478483.0, 478842.0, 479564.0, 58247.67009319665, 58683.11975320373, 58805.41194588085, 58850.70574647185, 58880.0, 60996.69501652463, 61392.07911881326, 62135.0, 62282.688586556775, 62317.37682623207, 15750.527484175493, 15927.920360398355, 15932.522024339289, 15947.282372293275, 15950.202489875692, 11131.499082541304, 11402.543898243977, 12240.938795305967, 12468.875311246771, 12488.25070495773, 18262.0, 18447.16987735555, 18509.7223541647, 18525.258989640264, 18621.90689046546, 8150.551719655476, 8229.300509456643, 8233.094359620436, 8242.629081691339, 8284.337253019745, 780.6331024418514, 782.6772754045645, 841.2807049972185, 878.0, 895.8118795052982, 30281.24296892595, 30664.540031899538, 30912.0, 31278.06165815029, 31431.685683143332, 1037.8754549454113, 1039.2465462539749, 1069.1607088435542, 1076.69852441315, 1242.67069226655, 13659.292588426446, 15277.38890444392, 16712.665746684997, 16818.24317905697, 17225.39711110105, 638116.0, 638707.0, 640081.799590999, 642515.7874210599, 643131.0, 65002.349976500576, 65209.0, 65898.67050664716, 65944.01083983744, 66020.66989665022, 1294.890352820696, 1486.323722706166, 1487.5091219897408, 1519.3770554072778, 1526.5572983834563, 29553.26116847096, 30615.693843061283, 30872.837318573424, 31013.379732405676, 31058.378832423678, 54425.0, 54955.725221373636, 55127.89744205013, 55224.72387638036, 55260.17109743437, 571440.0, 573369.0, 576164.0, 579707.0, 580393.0, 43341.783291083346, 43995.68012959616, 44503.33245001392, 44567.88580285519, 44722.3291650632, 47520.287195692785, 47756.5224347766, 48000.27999580079, 49306.75346623387, 49427.50572494229, 39696.0, 40041.799791000856, 40352.596474034886, 40847.774566763044, 41524.0, 39382.409263861635, 39413.2117357657, 39728.40407393949, 40554.79722601368, 40609.59390406058, 38165.618343816204, 38318.23363532769, 38804.61195388123, 39118.80440597779, 39131.80434097925, 34320.65679343275, 34845.825770872, 35424.0, 35603.10992225215, 35654.0, 25529.74470255348, 25685.229443116736, 25695.357616059748, 25786.484270314864, 26252.343691407103], "value": 20818.883444407158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.46232661254083, 393.51990571502756, 397.1956787505302, 397.6520544523542, 419.3918817714313, 15676.451324203626, 19622.70565941512, 20377.08303126359, 20921.47696307591, 20937.47656308593, 21217.787822121772, 21231.57536849262, 21526.461838454008, 21965.23121690741, 22302.553948921053, 5676.262085928834, 5865.149553314767, 5891.145783861338, 5907.7636894524385, 5915.231019967398, 5630.436956304357, 5773.249477567911, 5773.913391299113, 5880.794172203974, 5885.4997325227405, 5777.277840269966, 5788.71056447178, 5788.97105514474, 5790.247267855173, 5806.187133801272, 5539.086050801613, 5539.169124631298, 5785.161151633031, 5785.334686511042, 5788.305403351604, 5077.974610126926, 5088.745562721849, 5088.745562721849, 5099.413567439718, 5105.336306280197, 25545.872270638713, 25715.35711607206, 25935.481290374086, 25970.350741231432, 26034.479310413873, 2743.1633351827686, 2773.4037182005763, 2790.9302267443477, 2798.818076825, 2799.9160025199276, 11466.2546934449, 11890.643280701594, 12977.740445191042, 13093.607191784167, 14668.753155981754, 1729.8060806811754, 1828.3874901907743, 1828.4331857124334, 1838.0717737542589, 1873.9718904216447, 116112.0, 116726.0, 117587.41206294, 118084.0, 118098.77690044936, 11575.826362604568, 11789.292642441482, 11818.231814932002, 11864.525418983316, 11895.750946150703, 13017.674558136123, 13957.511487097903, 14775.778363324558, 14783.70432591342, 14783.778243326358, 7800.180980997027, 8453.239208471266, 8644.265237454762, 8798.38411311202, 8956.104389560991, 8684.739457816275, 8716.869246961302, 8746.781330466789, 8789.560521973875, 8881.555922203865, 7314.890276645855, 7440.627968601657, 7443.404527637776, 7452.701891924371, 7463.0, 1918.9136488858035, 1946.8442524598, 1954.7556555430572, 1959.0694420150314, 1969.1138987455702, 1059.6397224943403, 1059.814532456817, 1070.9946450267698, 1073.1629329123296, 1107.5126944144552, 22021.66967495489, 22094.88952555259, 22178.223762168247, 22190.445238868833, 22200.77799221987, 1091.5524634899652, 1095.7534554725123, 1106.7399161197113, 1112.249231768553, 1120.383788916093, 11260.155488338407, 11832.822507662391, 12038.578649747393, 12046.397680115959, 12070.456829442695, 736041.0, 749302.0, 752826.2358688172, 757777.0, 769524.0, 135667.0, 136004.0, 136262.0, 139354.0, 156360.0, 1039.1323245090434, 1057.1331508163387, 1084.6312253833735, 1085.696005118568, 1087.1683162380784, 19116.426507204807, 19356.70964935499, 20169.798302016792, 20261.088251029032, 20394.980250987093, 61674.0, 62639.6868015657, 63160.36839631729, 63648.68175659092, 64173.67913160404, 82492.58753706433, 83631.5818420904, 84472.57763711142, 86527.1347286519, 87312.1268787304, 8239.340852731648, 8298.751037468886, 8478.660853565789, 8590.269827064769, 8802.515861627671, 12479.93760031194, 12843.293618851052, 13051.412686428943, 13201.669958250737, 13279.070465067352, 10972.451377431256, 11094.833577496183, 11150.940660637227, 11370.602028928948, 11486.425678716198, 10773.730656733644, 11081.335119892832, 11107.777844443228, 11256.380899050631, 11312.547498099984, 11287.661370158909, 11438.542458301908, 11483.712907177387, 11514.654560363202, 11867.58463453775, 8376.371772116994, 8403.70587029451, 8457.492550446992, 8514.191151840565, 8581.742547723577, 8731.694390696295, 9225.815483690423, 10915.235933484897, 11113.499892505019, 11235.157363197957], "value": 10160.910302661188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.2221778022085, 1441.9639509012272, 1445.2845841308554, 1445.4940770730245, 1448.7319845828522, 6664.700088496017, 7452.0, 7702.037245344332, 8390.79023024424, 8429.873551896726, 7948.7217947371855, 8127.715529956438, 8192.303654189402, 8309.418340716153, 8357.749267521984, 2315.9305220843403, 2348.43637526994, 2356.611159158737, 2356.8468049576722, 2357.222116701493, 1727.1709579401895, 2013.476496111007, 2301.0795681727277, 2343.0, 2392.0, 2292.64464008079, 2328.592496313147, 2330.0796185506715, 2332.5917964356254, 2333.0784340185614, 2303.470201853583, 2314.618088015475, 2321.7330007049236, 2334.4397344637164, 2340.648902664597, 2133.5092928626505, 2164.945876353088, 2339.801116905065, 2350.823688223373, 2377.2036367816804, 8394.79013024673, 8396.034456037572, 8440.535770532619, 8443.662253509852, 8453.070162282143, 5146.897062058775, 5228.137357336035, 5228.241904923802, 5235.973820130913, 5242.1088414969545, 3221.5167724841226, 3428.639992800745, 3461.7576769626135, 3463.1688394785324, 3532.487789270567, 1177.7232350397649, 1196.07304339137, 1210.4189988805335, 1214.4838443661408, 1242.142921384251, 10667.733306667318, 10688.78622427547, 10757.354558726423, 10769.78460430787, 10810.459477026117, 4429.092036132585, 4690.460597031317, 4743.549362810528, 4745.217039188564, 4757.024809913959, 9474.573644186028, 9526.571304291323, 9593.13661770444, 9595.568199431042, 9601.951990240144, 5185.870353241199, 5242.68543887368, 5261.210818377274, 5265.6050796189675, 5266.97366513165, 4322.805473753689, 4396.406485124531, 4791.544803243756, 4827.951720482821, 4835.782389792468, 3405.8126803025575, 3935.626115519021, 3959.6238357356006, 3976.383660532622, 3994.940075898864, 1177.9810463948622, 1216.2094638484878, 1248.818921256431, 1282.5639282643947, 1285.183908218288, 815.5188438821124, 880.4497189256715, 883.7186080183759, 914.154407173362, 926.7961048569304, 5791.8552036199435, 5824.184614154022, 5847.9357146063785, 5894.440028197314, 6066.545009124334, 892.3307519360479, 984.7439665686973, 997.670768646345, 1020.2501161646184, 1048.5438834107188, 3623.691986181204, 3677.595464498903, 3696.5748938872375, 3767.2088861339425, 3838.3858582627204, 9421.152096311365, 9839.901600983898, 9843.509123264472, 9897.406155630686, 9940.602375905028, 8299.585020749058, 9712.271579631555, 9734.318597698235, 9800.852987205197, 9807.26445516589, 7663.6168191590195, 7670.539767613961, 7750.883736743954, 7792.688292468351, 7901.565413902175, 5378.462153784591, 5485.122380419114, 5496.780128794803, 5545.916811247916, 5642.463965923231, 9124.31567632417, 9149.63401463934, 9205.585748641193, 9298.674546390845, 9302.720918372459, 8973.910260897308, 9371.531423428665, 9380.48407337603, 9397.624095036123, 9400.858987115336, 7017.578945263096, 7099.787006389816, 7116.359527642537, 7136.357727804522, 7151.356377926011, 7711.730089446843, 7732.806679832825, 7791.961040194763, 7804.492707973964, 7841.215878412113, 6408.359164083555, 6674.9332506676255, 6745.831354216184, 6760.594364338155, 7073.3987611053635, 6810.250872404131, 6912.723491060301, 6931.0, 7047.612381319077, 7050.471214658818, 6303.527235457267, 6381.457576106083, 6382.393672601095, 6385.233771947396, 6407.10300557913, 4026.4765580475523, 4859.805607775649, 4864.246041863516, 4961.578265847444, 5057.848264552069, 4892.584130348961, 4985.725785081855, 5006.674566153189, 5048.091343558195, 5051.040302342543], "value": 4400.21477653741, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.64814111912426, 322.445811190064, 327.3436759297611, 349.08887802834596, 360.1698085911973, 4663.860084197471, 4849.0, 5156.685045313449, 5352.973235133829, 5572.832815015546, 4634.443866735988, 4750.952490475094, 5088.7964481420695, 5205.386330237629, 5396.325459317585, 3271.2803183299634, 3712.795796231206, 4145.233131870614, 4263.87208383749, 4266.445362102922, 3691.7969511676847, 3869.496965394509, 4161.0, 4290.54949230331, 4291.206126866539, 4038.9296836338394, 4055.472788537486, 4066.715329926906, 4072.8370865165357, 4074.22589707956, 3566.144125409883, 4058.634722874926, 4062.817173227197, 4077.612626800449, 4092.015372544314, 3540.8583656653705, 3547.0600290922926, 3553.7690050146916, 3560.1989552350774, 3574.3744844652083, 4132.566080561528, 5140.228965655144, 5270.9736451317885, 5313.495217954288, 5329.813456529042, 4391.451068616423, 4450.709294304648, 4661.27315520421, 4661.976690116528, 4695.577398034159, 4339.826406943718, 4550.772461376918, 4767.713937163747, 5644.57665675076, 5687.886242275132, 3748.7938163401004, 3775.207206486614, 3868.32304346741, 3891.9805400972814, 3928.8428462861452, 4535.705179163377, 5552.111662134039, 5641.576881733887, 5831.329397119343, 6017.0, 3934.350832112669, 3945.072907866649, 3959.495391751116, 3962.6725047108966, 3963.781991990468, 3593.5446144311595, 3617.222297206113, 3823.4323927189716, 3985.8405663773706, 4013.959860401417, 4276.593723596254, 4631.675782695246, 4647.930281045787, 4658.906821863544, 4724.2205036169335, 4833.468318484964, 5289.920651190235, 5847.298324201038, 5857.824265272048, 5864.706764661835, 1154.4054811771944, 1249.5501619417003, 1261.5080118753694, 1304.7977563477486, 1304.8564657887625, 696.4150113904344, 770.818857568471, 809.4333966223667, 859.7170387966039, 886.3618194899661, 4592.7014744041535, 4719.560534037083, 5277.021117081094, 5282.867928301823, 5283.0, 4947.604191664658, 5441.59188060897, 5691.402402747734, 5740.598158128974, 5754.74103665336, 4996.725180115056, 5068.57870937116, 5200.427952925175, 5209.4009188943, 5228.163948347763, 2835.8865645374367, 2964.9258768530526, 2980.0, 3047.9542806857917, 3051.0389227393744, 5602.65536271292, 5907.442738560195, 5996.2504686914135, 6015.488683461867, 6023.397660234029, 4929.605631549467, 5429.19076588047, 5464.699441530754, 5798.94201057984, 5869.735861886225, 4933.038057578881, 5190.4445454863535, 5195.376554813447, 5364.81973965727, 5426.403095659474, 4847.660663753503, 5023.0, 5232.389651140701, 5515.751791169488, 5795.145553423033, 5198.818041368534, 5209.76556054986, 5249.482846492935, 5365.973170134124, 5381.627684940315, 4743.343727512604, 5314.0, 5561.721913904369, 5816.680082595498, 6008.729607167776, 3531.0819187011048, 3683.50272713191, 3768.1521657626813, 3785.280796648738, 3789.261094086737, 5368.40947495783, 5586.497215250484, 5600.0, 5651.463111004448, 5714.285714285715, 4927.457979622311, 5550.611457197957, 5580.888382232414, 5773.278340207474, 5784.768609255582, 4773.76131193432, 5709.457601527848, 5733.942660573341, 5755.5971082025535, 5760.308762948473, 4977.4524802271, 5133.79464821403, 5462.825492519128, 5653.201665175764, 5681.829545113653, 4629.814807407666, 5476.753546090516, 5640.012997725464, 5699.6580205186165, 5756.71216439168, 5157.896842063213, 5615.887682246251, 5617.74720137603, 5639.210510528447, 5643.830685079454], "value": 4064.635617649506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6160169504233, 681.567204824936, 757.7310054930499, 821.8602837517622, 828.954407507587, 11878.643640690772, 12310.322932238723, 14850.851491485082, 14862.405503779863, 14907.403703851847, 14343.856561434382, 14531.92734036331, 14559.126452412862, 14561.271936403191, 14562.199079050648, 668.5587512241922, 688.8553403785186, 835.4360806455618, 854.2738672128672, 857.9742607721778, 858.4977787994031, 870.8998465176522, 872.2890843962182, 872.4242000279817, 875.8379699755566, 784.1883650421814, 925.6112432778249, 926.6710317837172, 928.4475736936546, 929.7117893453018, 918.779492921694, 925.8379783537888, 926.2543652359848, 926.6247169896203, 931.5388882503204, 681.0567364200568, 689.4622194688101, 690.3579670906055, 690.4579904774778, 690.7547820523693, 14766.187859667714, 15127.54617361481, 15129.319180636898, 15448.073115613099, 15552.0, 11848.28910265387, 11984.280943143352, 12006.69983250417, 12157.0, 12364.763523647653, 11301.755680288737, 11707.414629268587, 11716.648500544998, 11800.0, 12072.818907716392, 3734.1224812169116, 3786.053486628343, 3789.8673546426016, 3858.1704933439164, 3901.395283731026, 95944.52027739887, 96386.0, 96625.0, 97114.51442742882, 97707.0, 10955.287906286225, 11027.61403350895, 11046.944765276123, 11116.888831111748, 11213.21507494484, 22432.66351004736, 22800.087996480288, 22836.88581557115, 22849.0, 22856.428589285068, 7783.494072885244, 7805.297523222937, 7836.216378362232, 7903.565303908225, 8028.197180282042, 4193.51774545925, 4231.196072746168, 4288.078063216361, 4296.3555466680245, 4300.225959327288, 3433.656634336546, 3475.913102172466, 3486.564179477565, 3524.277523107808, 3529.1177205698577, 614.8555089553952, 619.102301662582, 624.8531595075153, 636.1539152926597, 646.0277282689523, 681.4480270980522, 697.2012208502052, 698.0855079845419, 717.3651318582987, 736.3005145112057, 9674.274429417821, 9791.314607977516, 9913.950430247802, 10376.948115259376, 10403.0, 688.8997923388423, 704.9718011279595, 705.7776800307887, 708.6881772020295, 721.7257442171941, 4871.732054737024, 4972.328735620645, 4988.55103040728, 5007.6494645375205, 5008.699478031257, 106489.0, 107784.46107769411, 111292.0, 111761.44119279351, 112905.0, 92362.0, 93762.0, 95759.0, 97441.0, 97819.02180978241, 63457.365426345146, 84083.57958210292, 84287.0, 84649.57675211708, 85761.0, 10271.845922311022, 10966.451677415938, 11079.50142243585, 11107.278026928223, 11144.164187685794, 41650.58349416467, 42456.0, 47251.109955601394, 50694.493055068975, 51510.85859715526, 57183.0, 60798.0, 65688.67155664192, 67251.0, 67432.0, 10945.726356841144, 11176.608818691308, 11339.829902551633, 13134.408951597392, 13589.252591107585, 14762.557123286319, 14883.404663813326, 14975.700485990437, 15298.770518442456, 15363.846361536242, 13567.72864542684, 14178.645533861736, 14249.786253206417, 14304.213268270345, 14457.204853732725, 13534.93232533831, 13776.24230667323, 13844.584662460142, 13938.30308484592, 14149.575512734635, 12893.677658058248, 13100.541481048118, 13538.187708737507, 13975.694010488156, 14066.085704429179, 9186.632534698538, 10747.301425407324, 11428.94285528567, 11439.942800286279, 11557.30656160633, 9603.423794572349, 9668.85496717564, 10753.649091450638, 10960.725981850517, 10966.342019478856], "value": 7502.516635101463, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 119.0, 118.0, 118.0, 116.0, 119.0, 119.0, 118.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 115.0, 149.0, 106.0, 155.0, 147.0, 148.0, 135.0, 117.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 199.0, 199.0, 200.0, 198.0, 195.0, 201.0, 196.0, 200.0, 200.0], "value": 198.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 60.0, 89.0, 67.0, 69.0, 51.0, 65.0, 84.0, 83.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 70.0, 90.0, 85.0, 100.0, 115.0, 103.0, 63.0, 103.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 86.0, 88.0, 87.0, 91.0, 95.0, 89.0, 89.0, 130.0, 120.0], "value": 99.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 105.0, 99.0, 121.0, 99.0, 152.0, 170.0, 118.0, 168.0], "value": 123.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 98.0, 93.0, 92.0, 95.0, 93.0, 92.0, 96.0, 93.0, 92.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 61.0, 64.0, 64.0, 64.0, 77.0, 91.0, 97.0], "value": 70.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 67.0, 83.0, 81.0, 75.0, 70.0, 71.0, 73.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 87.0, 88.0, 85.0, 84.0, 86.0, 87.0, 87.0, 84.0, 86.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 155.0, 148.0, 153.0, 145.0, 144.0, 144.0, 236.0, 141.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 171.0, 170.0, 214.0, 160.0, 219.0, 228.0, 170.0, 227.0], "value": 190.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 77.0, 86.0, 85.0, 74.0, 68.0, 67.0, 68.0, 65.0, 67.0], "value": 71.9, "unit": "score"}]}]} 12:06:42 INFO - Return code: 0 12:06:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:06:42 ERROR - # TBPL SUCCESS # 12:06:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:06:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:06:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:06:42 INFO - 2017-02-06 12:06:42.707 screenresolution[2185:24086] starting screenresolution argv=screenresolution get 12:06:42 INFO - 2017-02-06 12:06:42.710 screenresolution[2185:24086] Display 0: 1600x1200x32@60 12:06:42 INFO - 2017-02-06 12:06:42.716 screenresolution[2186:24089] starting screenresolution argv=screenresolution list 12:06:42 INFO - Available Modes on Display 0 12:06:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:06:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:06:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:06:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:06:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:06:42 INFO - Intel Iris: 12:06:42 INFO - Chipset Model: Intel Iris 12:06:42 INFO - Type: GPU 12:06:42 INFO - Bus: Built-In 12:06:42 INFO - VRAM (Dynamic, Max): 1536 MB 12:06:42 INFO - Vendor: Intel (0x8086) 12:06:42 INFO - Device ID: 0x0a2e 12:06:42 INFO - Revision ID: 0x0009 12:06:42 INFO - Displays: 12:06:42 INFO - Display: 12:06:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:06:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:06:42 INFO - Display Serial Number: 1600x1200 60 12:06:42 INFO - Main Display: Yes 12:06:42 INFO - Mirror: Off 12:06:42 INFO - Online: Yes 12:06:42 INFO - Rotation: Supported 12:06:42 INFO - Return code: 0 12:06:42 INFO - Running post-action listener: _resource_record_post_action 12:06:42 INFO - [mozharness: 2017-02-06 20:06:42.957958Z] Finished run-tests step (success) 12:06:42 INFO - Running post-run listener: _resource_record_post_run 12:06:43 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1598976; Write bytes: 507604480; Read time: 15; Write time: 1925 12:06:43 INFO - TinderboxPrint: CPU usage
54.2% 12:06:43 INFO - TinderboxPrint: I/O read bytes / time
1,598,976 / 15 12:06:43 INFO - TinderboxPrint: I/O write bytes / time
507,604,480 / 1,925 12:06:43 INFO - TinderboxPrint: CPU idle
2,195.5 (45.8%) 12:06:43 INFO - TinderboxPrint: CPU system
959.8 (20.0%) 12:06:43 INFO - TinderboxPrint: CPU user
1,634.4 (34.1%) 12:06:43 INFO - TinderboxPrint: Swap in / out
209,215,488 / 0 12:06:43 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205134336; Write bytes: 198688768; Read time: 15760; Write time: 369 12:06:43 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1549824; Write bytes: 297893376; Read time: 15; Write time: 1515 12:06:43 INFO - Running post-run listener: _upload_blobber_files 12:06:43 INFO - Blob upload gear active. 12:06:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:06:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:06:43 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'] 12:06:43 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 12:06:43 INFO - (blobuploader) - INFO - Open directory for files ... 12:06:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:06:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:44 INFO - (blobuploader) - INFO - Done attempting. 12:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:45 INFO - (blobuploader) - INFO - Done attempting. 12:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:06:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:47 INFO - (blobuploader) - INFO - Done attempting. 12:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:49 INFO - (blobuploader) - INFO - Done attempting. 12:06:49 INFO - (blobuploader) - INFO - Iteration through files over. 12:06:49 INFO - Return code: 0 12:06:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:06:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:06:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d105571c367a8829fbd5499def218ac1e0b7b7f9f7b529a0c2331c6ac9f9d2d5e20bdf807f52bd05c910d95d0afc6587f0a83f24bca8b30bbed584c57f5a2ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24f889c70672c072812624c07857883f4359d3da1571c2bc61c3be8477ddf5309b89467cb1a2f85b804066704cc5aed4a65fab178da1cb50a823d2d09d9d8307", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70572ad0749a63bc07ba8865b9217c85c0cb2874784c6bbd07432aa8c5ebd52f08e5e5f70e0802ccc403b5fc779a6a0c237781b4671730657af633cfbe10965e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f46914064ece513377f987ba181abec03fb3de7d60f2c07df31461d7c41ae48c3602e0460a4d133530718541fa91f548b51d6aaef0f548429c66f0463df116"} 12:06:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:06:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:06:49 INFO - Contents: 12:06:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d105571c367a8829fbd5499def218ac1e0b7b7f9f7b529a0c2331c6ac9f9d2d5e20bdf807f52bd05c910d95d0afc6587f0a83f24bca8b30bbed584c57f5a2ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24f889c70672c072812624c07857883f4359d3da1571c2bc61c3be8477ddf5309b89467cb1a2f85b804066704cc5aed4a65fab178da1cb50a823d2d09d9d8307", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70572ad0749a63bc07ba8865b9217c85c0cb2874784c6bbd07432aa8c5ebd52f08e5e5f70e0802ccc403b5fc779a6a0c237781b4671730657af633cfbe10965e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f46914064ece513377f987ba181abec03fb3de7d60f2c07df31461d7c41ae48c3602e0460a4d133530718541fa91f548b51d6aaef0f548429c66f0463df116"} 12:06:49 INFO - Running post-run listener: copy_logs_to_upload_dir 12:06:49 INFO - Copying logs to upload dir... 12:06:49 INFO - mkdir: /builds/slave/test/build/upload/logs 12:06:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.277390 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-06 12:06:49.344734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 12:06:49.347936) ========= 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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/9d105571c367a8829fbd5499def218ac1e0b7b7f9f7b529a0c2331c6ac9f9d2d5e20bdf807f52bd05c910d95d0afc6587f0a83f24bca8b30bbed584c57f5a2ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24f889c70672c072812624c07857883f4359d3da1571c2bc61c3be8477ddf5309b89467cb1a2f85b804066704cc5aed4a65fab178da1cb50a823d2d09d9d8307", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70572ad0749a63bc07ba8865b9217c85c0cb2874784c6bbd07432aa8c5ebd52f08e5e5f70e0802ccc403b5fc779a6a0c237781b4671730657af633cfbe10965e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f46914064ece513377f987ba181abec03fb3de7d60f2c07df31461d7c41ae48c3602e0460a4d133530718541fa91f548b51d6aaef0f548429c66f0463df116"} build_url:https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/HSKNOoL6T-WuNCrPL8HZQw/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/9d105571c367a8829fbd5499def218ac1e0b7b7f9f7b529a0c2331c6ac9f9d2d5e20bdf807f52bd05c910d95d0afc6587f0a83f24bca8b30bbed584c57f5a2ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24f889c70672c072812624c07857883f4359d3da1571c2bc61c3be8477ddf5309b89467cb1a2f85b804066704cc5aed4a65fab178da1cb50a823d2d09d9d8307", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70572ad0749a63bc07ba8865b9217c85c0cb2874784c6bbd07432aa8c5ebd52f08e5e5f70e0802ccc403b5fc779a6a0c237781b4671730657af633cfbe10965e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f46914064ece513377f987ba181abec03fb3de7d60f2c07df31461d7c41ae48c3602e0460a4d133530718541fa91f548b51d6aaef0f548429c66f0463df116"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 12:06:49.381416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:06:49.381735) ========= 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.lCOSmp9jf3/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.iDzAUDtmLL/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005360 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:06:49.430366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 12:06:49.430682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 12:06:49.431029) ========= ========= Total master_lag: 0.18 =========