builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0301 starttime: 1486638176.75 results: success (0) buildid: 20170209021221 builduid: 0e5d3ee6f05b4f4c97a0d5b2eb538741 revision: bc736e4fab076b947c7918dba41af3d015e3ad22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.755176) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.755919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.756528) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.784925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.785576) ========= 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.f678zjEpwf/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.c5mQBlNXv3/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-09 03:02:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.7M=0.001s 2017-02-09 03:02:56 (16.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089203 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.903063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.903807) ========= 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.f678zjEpwf/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.c5mQBlNXv3/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.026358 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:56.956825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-09 03:02:56.957601) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bc736e4fab076b947c7918dba41af3d015e3ad22 --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 bc736e4fab076b947c7918dba41af3d015e3ad22 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f678zjEpwf/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.c5mQBlNXv3/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-09 03:02:57,063 truncating revision to first 12 chars 2017-02-09 03:02:57,063 Setting DEBUG logging. 2017-02-09 03:02:57,064 attempt 1/10 2017-02-09 03:02:57,064 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bc736e4fab07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 03:02:59,143 unpacking tar archive at: mozilla-aurora-bc736e4fab07/testing/mozharness/ program finished with exit code 0 elapsedTime=2.354773 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-09 03:02:59.337606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:59.337994) ========= script_repo_revision: bc736e4fab076b947c7918dba41af3d015e3ad22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:59.338466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:59.338772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 03:02:59.358644) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-09 03:02:59.359061) ========= /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.f678zjEpwf/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.c5mQBlNXv3/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:02:59 INFO - MultiFileLogger online at 20170209 03:02:59 in /builds/slave/test 03:02:59 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 03:02:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:02:59 INFO - {'append_to_log': False, 03:02:59 INFO - 'base_work_dir': '/builds/slave/test', 03:02:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:02:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:02:59 INFO - 'branch': 'Mozilla-Aurora', 03:02:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:02:59 INFO - 'config_files': ('talos/mac_config.py',), 03:02:59 INFO - 'default_actions': ('clobber', 03:02:59 INFO - 'read-buildbot-config', 03:02:59 INFO - 'download-and-extract', 03:02:59 INFO - 'populate-webroot', 03:02:59 INFO - 'create-virtualenv', 03:02:59 INFO - 'install', 03:02:59 INFO - 'run-tests'), 03:02:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:02:59 INFO - 'download_minidump_stackwalk': True, 03:02:59 INFO - 'download_symbols': 'ondemand', 03:02:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:02:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:02:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:02:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:02:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:02:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:02:59 INFO - 'installer_path': 'installer.exe', 03:02:59 INFO - 'log_level': 'info', 03:02:59 INFO - 'log_name': 'talos', 03:02:59 INFO - 'log_to_console': True, 03:02:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:02:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:02:59 INFO - 'opt_config_files': (), 03:02:59 INFO - 'pip_index': False, 03:02:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:59 INFO - 'cmd': ('bash', 03:02:59 INFO - '-c', 03:02:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:59 INFO - 'enabled': True, 03:02:59 INFO - 'halt_on_failure': False, 03:02:59 INFO - 'name': 'check_screen_resolution'},), 03:02:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:59 INFO - 'cmd': ('bash', 03:02:59 INFO - '-c', 03:02:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:59 INFO - 'enabled': True, 03:02:59 INFO - 'halt_on_failure': False, 03:02:59 INFO - 'name': 'check_screen_resolution'},), 03:02:59 INFO - 'run_cmd_checks_enabled': True, 03:02:59 INFO - 'sps_profile': False, 03:02:59 INFO - 'sps_profile_interval': 0, 03:02:59 INFO - 'suite': 'dromaeojs-e10s', 03:02:59 INFO - 'system_bits': '32', 03:02:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:02:59 INFO - 'title': 't-yosemite-r7-0301', 03:02:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:02:59 INFO - 'use_talos_json': True, 03:02:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:02:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:02:59 INFO - 'work_dir': 'build'} 03:02:59 INFO - [mozharness: 2017-02-09 11:02:59.571295Z] Running clobber step. 03:02:59 INFO - Running pre-action listener: _resource_record_pre_action 03:02:59 INFO - Running main action method: clobber 03:02:59 INFO - rmtree: /builds/slave/test/build 03:02:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:03:02 INFO - Running post-action listener: _resource_record_post_action 03:03:02 INFO - [mozharness: 2017-02-09 11:03:02.071249Z] Finished clobber step (success) 03:03:02 INFO - [mozharness: 2017-02-09 11:03:02.071402Z] Running read-buildbot-config step. 03:03:02 INFO - Running pre-action listener: _resource_record_pre_action 03:03:02 INFO - Running main action method: read_buildbot_config 03:03:02 INFO - Using buildbot properties: 03:03:02 INFO - { 03:03:02 INFO - "project": "", 03:03:02 INFO - "product": "firefox", 03:03:02 INFO - "script_repo_revision": "production", 03:03:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:03:02 INFO - "repository": "", 03:03:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:03:02 INFO - "buildid": "20170209021221", 03:03:02 INFO - "pgo_build": "False", 03:03:02 INFO - "basedir": "/builds/slave/test", 03:03:02 INFO - "buildnumber": 42, 03:03:02 INFO - "slavename": "t-yosemite-r7-0301", 03:03:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:03:02 INFO - "platform": "yosemite_r7", 03:03:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:03:02 INFO - "branch": "mozilla-aurora", 03:03:02 INFO - "repo_path": "releases/mozilla-aurora", 03:03:02 INFO - "revision": "bc736e4fab076b947c7918dba41af3d015e3ad22", 03:03:02 INFO - "stage_platform": "macosx64", 03:03:02 INFO - "builduid": "0e5d3ee6f05b4f4c97a0d5b2eb538741", 03:03:02 INFO - "slavebuilddir": "test" 03:03:02 INFO - } 03:03:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 03:03:02 INFO - Running post-action listener: _resource_record_post_action 03:03:02 INFO - [mozharness: 2017-02-09 11:03:02.074631Z] Finished read-buildbot-config step (success) 03:03:02 INFO - [mozharness: 2017-02-09 11:03:02.074738Z] Running download-and-extract step. 03:03:02 INFO - Running pre-action listener: _resource_record_pre_action 03:03:02 INFO - Running main action method: download_and_extract 03:03:02 INFO - mkdir: /builds/slave/test/build/tests 03:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:02 INFO - trying https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 03:03:02 INFO - Downloading https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/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 03:03:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/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 03:03:03 INFO - Downloaded 1199 bytes. 03:03:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 03:03:03 INFO - Using the following test package requirements: 03:03:03 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 03:03:03 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 03:03:03 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 03:03:03 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'jsshell-mac.zip'], 03:03:03 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 03:03:03 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 03:03:03 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 03:03:03 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 03:03:03 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 03:03:03 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:03:03 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 03:03:03 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:03:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 03:03:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:03:03 INFO - Fetch https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 03:03:04 INFO - Expected file size: 16357990 03:03:04 INFO - Obtained file size: 16357990 03:03:10 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 03:03:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 03:03:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:03:10 INFO - Fetch https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 03:03:11 INFO - Expected file size: 16357990 03:03:11 INFO - Obtained file size: 16357990 03:03:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 03:03:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:03:18 INFO - Fetch https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 03:03:19 INFO - Expected file size: 14403485 03:03:19 INFO - Obtained file size: 14403485 03:03:19 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')]} 03:03:19 INFO - trying https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:03:19 INFO - Downloading https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 03:03:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/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 03:03:21 INFO - Downloaded 73821042 bytes. 03:03:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:03:21 INFO - mkdir: /builds/slave/test/properties 03:03:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:21 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:21 INFO - Contents: 03:03:21 INFO - build_url:https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:03:22 INFO - Running post-action listener: _resource_record_post_action 03:03:22 INFO - Running post-action listener: set_extra_try_arguments 03:03:22 INFO - [mozharness: 2017-02-09 11:03:22.658813Z] Finished download-and-extract step (success) 03:03:22 INFO - [mozharness: 2017-02-09 11:03:22.658972Z] Running populate-webroot step. 03:03:22 INFO - Running pre-action listener: _resource_record_pre_action 03:03:22 INFO - Running main action method: populate_webroot 03:03:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:22 INFO - '--tppagecycles', 03:03:22 INFO - '7'], 03:03:22 INFO - 'tests': ['tsvgm']}}, 03:03:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:03:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:03:22 INFO - 'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:03:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:03:22 INFO - 'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['damp', 'tps']}, 03:03:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:03:22 INFO - 'tests': ['damp', 'tps']}, 03:03:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['dromaeo_dom']}, 03:03:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['basic_compositor_video']}, 03:03:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:03:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['a11yr', 03:03:22 INFO - 'ts_paint', 03:03:22 INFO - 'tpaint', 03:03:22 INFO - 'sessionrestore', 03:03:22 INFO - 'sessionrestore_no_auto_restore', 03:03:22 INFO - 'tabpaint']}, 03:03:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:22 INFO - 'ts_paint', 03:03:22 INFO - 'tpaint', 03:03:22 INFO - 'sessionrestore', 03:03:22 INFO - 'sessionrestore_no_auto_restore', 03:03:22 INFO - 'tabpaint']}, 03:03:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:03:22 INFO - 'ts_paint', 03:03:22 INFO - 'tpaint', 03:03:22 INFO - 'sessionrestore', 03:03:22 INFO - 'sessionrestore_no_auto_restore', 03:03:22 INFO - 'tabpaint']}, 03:03:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:03:22 INFO - 'ts_paint', 03:03:22 INFO - 'tpaint', 03:03:22 INFO - 'sessionrestore', 03:03:22 INFO - 'sessionrestore_no_auto_restore', 03:03:22 INFO - 'tabpaint']}, 03:03:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['a11yr', 03:03:22 INFO - 'ts_paint', 03:03:22 INFO - 'tpaint', 03:03:22 INFO - 'sessionrestore', 03:03:22 INFO - 'sessionrestore_no_auto_restore', 03:03:22 INFO - 'tabpaint']}, 03:03:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['a11yr', 03:03:22 INFO - 'ts_paint', 03:03:22 INFO - 'tpaint', 03:03:22 INFO - 'sessionrestore', 03:03:22 INFO - 'sessionrestore_no_auto_restore', 03:03:22 INFO - 'tabpaint']}, 03:03:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['tsvgx', 03:03:22 INFO - 'tsvgr_opacity', 03:03:22 INFO - 'tart', 03:03:22 INFO - 'tscrollx', 03:03:22 INFO - 'cart', 03:03:22 INFO - 'tsvg_static']}, 03:03:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:22 INFO - 'tsvgr_opacity', 03:03:22 INFO - 'tart', 03:03:22 INFO - 'tscrollx', 03:03:22 INFO - 'cart', 03:03:22 INFO - 'tsvg_static']}, 03:03:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:03:22 INFO - 'talos_options': ['--disable-e10s'], 03:03:22 INFO - 'tests': ['tp5o']}, 03:03:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:03:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:03:22 INFO - 'talos_options': ['--disable-e10s', 03:03:22 INFO - '--xperf_path', 03:03:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:22 INFO - 'tests': ['tp5n']}, 03:03:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:03:22 INFO - 'talos_options': ['--xperf_path', 03:03:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:22 INFO - 'tests': ['tp5n']}}, 03:03:22 INFO - 'talos.zip': {'path': '', 03:03:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:22 INFO - Running post-action listener: _resource_record_post_action 03:03:22 INFO - [mozharness: 2017-02-09 11:03:22.677473Z] Finished populate-webroot step (success) 03:03:22 INFO - [mozharness: 2017-02-09 11:03:22.677609Z] Running create-virtualenv step. 03:03:22 INFO - Running pre-action listener: _resource_record_pre_action 03:03:22 INFO - Running main action method: create_virtualenv 03:03:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:22 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 03:03:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:03:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:22 INFO - Using real prefix '/tools/python27' 03:03:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:26 INFO - Installing pip.................done. 03:03:26 INFO - Return code: 0 03:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:03:26 INFO - Reading from file tmpfile_stdout 03:03:26 INFO - Output received: 03:03:26 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) 03:03:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:26 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:26 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 03:03:26 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 03:03:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:26 INFO - 'HOME': '/Users/cltbld', 03:03:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:26 INFO - 'LOGNAME': 'cltbld', 03:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:26 INFO - 'MOZ_NO_REMOTE': '1', 03:03:26 INFO - 'NO_EM_RESTART': '1', 03:03:26 INFO - 'PAGER': '/bin/cat', 03:03:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:26 INFO - 'PWD': '/builds/slave/test', 03:03:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:26 INFO - 'SHELL': '/bin/bash', 03:03:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:26 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:26 INFO - 'USER': 'cltbld', 03:03:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:26 INFO - 'XPC_FLAGS': '0x0', 03:03:26 INFO - 'XPC_SERVICE_NAME': '0', 03:03:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:26 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 03:03:26 INFO - Cleaning up... 03:03:26 INFO - Return code: 0 03:03:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:26 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:26 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 03:03:26 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 03:03:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:26 INFO - 'HOME': '/Users/cltbld', 03:03:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:26 INFO - 'LOGNAME': 'cltbld', 03:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:26 INFO - 'MOZ_NO_REMOTE': '1', 03:03:26 INFO - 'NO_EM_RESTART': '1', 03:03:26 INFO - 'PAGER': '/bin/cat', 03:03:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:26 INFO - 'PWD': '/builds/slave/test', 03:03:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:26 INFO - 'SHELL': '/bin/bash', 03:03:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:26 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:26 INFO - 'USER': 'cltbld', 03:03:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:26 INFO - 'XPC_FLAGS': '0x0', 03:03:26 INFO - 'XPC_SERVICE_NAME': '0', 03:03:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:27 INFO - Downloading/unpacking psutil>=3.1.1 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:30 INFO - Installing collected packages: psutil 03:03:30 INFO - Running setup.py install for psutil 03:03:30 INFO - building 'psutil._psutil_osx' extension 03:03:30 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 03:03:31 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 03:03:31 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 03:03:31 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 03:03:31 INFO - building 'psutil._psutil_posix' extension 03:03:31 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 03:03:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:03:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:03:31 INFO - ^ 03:03:31 INFO - 1 warning generated. 03:03:31 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 03:03:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:31 INFO - Successfully installed psutil 03:03:31 INFO - Cleaning up... 03:03:31 INFO - Return code: 0 03:03:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:31 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:31 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 03:03:31 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 03:03:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:31 INFO - 'HOME': '/Users/cltbld', 03:03:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:31 INFO - 'LOGNAME': 'cltbld', 03:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:31 INFO - 'MOZ_NO_REMOTE': '1', 03:03:31 INFO - 'NO_EM_RESTART': '1', 03:03:31 INFO - 'PAGER': '/bin/cat', 03:03:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:31 INFO - 'PWD': '/builds/slave/test', 03:03:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:31 INFO - 'SHELL': '/bin/bash', 03:03:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:31 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:31 INFO - 'USER': 'cltbld', 03:03:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:31 INFO - 'XPC_FLAGS': '0x0', 03:03:31 INFO - 'XPC_SERVICE_NAME': '0', 03:03:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:03:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:03:34 INFO - Installing collected packages: mozsystemmonitor 03:03:34 INFO - Running setup.py install for mozsystemmonitor 03:03:35 INFO - Successfully installed mozsystemmonitor 03:03:35 INFO - Cleaning up... 03:03:35 INFO - Return code: 0 03:03:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:03:35 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')]} 03:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:35 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')]} 03:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:35 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:35 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 03:03:35 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 03:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:35 INFO - 'HOME': '/Users/cltbld', 03:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:35 INFO - 'LOGNAME': 'cltbld', 03:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:35 INFO - 'MOZ_NO_REMOTE': '1', 03:03:35 INFO - 'NO_EM_RESTART': '1', 03:03:35 INFO - 'PAGER': '/bin/cat', 03:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:35 INFO - 'PWD': '/builds/slave/test', 03:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:35 INFO - 'SHELL': '/bin/bash', 03:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:35 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:35 INFO - 'USER': 'cltbld', 03:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:35 INFO - 'XPC_FLAGS': '0x0', 03:03:35 INFO - 'XPC_SERVICE_NAME': '0', 03:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:03:35 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 03:03:35 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 03:03:35 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 03:03:35 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 03:03:35 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 03:03:35 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 03:03:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:03:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:03:38 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 03:03:38 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 03:03:38 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 03:03:38 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 03:03:38 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 03:03:38 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 03:03:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:03:38 INFO - warning: no files found matching '*.txt' 03:03:38 INFO - no previously-included directories found matching 'build' 03:03:38 INFO - no previously-included directories found matching 'dist' 03:03:38 INFO - no previously-included directories found matching '.git*' 03:03:38 INFO - Installing collected packages: jsonschema, functools32 03:03:38 INFO - Running setup.py install for functools32 03:03:38 INFO - warning: no files found matching '*.txt' 03:03:38 INFO - no previously-included directories found matching 'build' 03:03:38 INFO - no previously-included directories found matching 'dist' 03:03:38 INFO - no previously-included directories found matching '.git*' 03:03:38 INFO - Successfully installed jsonschema functools32 03:03:38 INFO - Cleaning up... 03:03:38 INFO - Return code: 0 03:03:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:38 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:38 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 03:03:38 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 03:03:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:38 INFO - 'HOME': '/Users/cltbld', 03:03:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:38 INFO - 'LOGNAME': 'cltbld', 03:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:38 INFO - 'MOZ_NO_REMOTE': '1', 03:03:38 INFO - 'NO_EM_RESTART': '1', 03:03:38 INFO - 'PAGER': '/bin/cat', 03:03:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:38 INFO - 'PWD': '/builds/slave/test', 03:03:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:38 INFO - 'SHELL': '/bin/bash', 03:03:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:38 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:38 INFO - 'USER': 'cltbld', 03:03:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:38 INFO - 'XPC_FLAGS': '0x0', 03:03:38 INFO - 'XPC_SERVICE_NAME': '0', 03:03:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:03:39 INFO - Cleaning up... 03:03:39 INFO - Return code: 0 03:03:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:39 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:39 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 03:03:39 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 03:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:39 INFO - 'HOME': '/Users/cltbld', 03:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:39 INFO - 'LOGNAME': 'cltbld', 03:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:39 INFO - 'MOZ_NO_REMOTE': '1', 03:03:39 INFO - 'NO_EM_RESTART': '1', 03:03:39 INFO - 'PAGER': '/bin/cat', 03:03:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:39 INFO - 'PWD': '/builds/slave/test', 03:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:39 INFO - 'SHELL': '/bin/bash', 03:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:39 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:39 INFO - 'USER': 'cltbld', 03:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:39 INFO - 'XPC_FLAGS': '0x0', 03:03:39 INFO - 'XPC_SERVICE_NAME': '0', 03:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:03:39 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 03:03:39 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 03:03:39 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 03:03:39 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 03:03:39 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 03:03:39 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 03:03:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:03:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:03:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:43 INFO - Downloading docopt-0.6.1.tar.gz 03:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:03:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:03:43 INFO - Running setup.py install for blobuploader 03:03:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:03:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:03:43 INFO - Running setup.py install for requests 03:03:43 INFO - Running setup.py install for docopt 03:03:44 INFO - Successfully installed blobuploader requests docopt 03:03:44 INFO - Cleaning up... 03:03:44 INFO - Return code: 0 03:03:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:44 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 03:03:44 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 03:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:44 INFO - 'HOME': '/Users/cltbld', 03:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:44 INFO - 'LOGNAME': 'cltbld', 03:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:44 INFO - 'MOZ_NO_REMOTE': '1', 03:03:44 INFO - 'NO_EM_RESTART': '1', 03:03:44 INFO - 'PAGER': '/bin/cat', 03:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:44 INFO - 'PWD': '/builds/slave/test', 03:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:44 INFO - 'SHELL': '/bin/bash', 03:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:44 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:44 INFO - 'USER': 'cltbld', 03:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:44 INFO - 'XPC_FLAGS': '0x0', 03:03:44 INFO - 'XPC_SERVICE_NAME': '0', 03:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:44 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-5h9F6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:44 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-z5DIOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:44 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-gjczu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:44 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-d5Nfau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:44 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-gfntkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:44 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Gw0M1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-nJKoOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-XDGr9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-wLTJnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-5J3USK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-oZBSAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-cdJz1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-ACYemy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-YrK_QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-hlJPK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:45 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-JiKek0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:46 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-pVLGOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:03:46 INFO - Running setup.py install for manifestparser 03:03:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:03:46 INFO - Running setup.py install for mozcrash 03:03:46 INFO - Running setup.py install for mozdebug 03:03:46 INFO - Running setup.py install for mozdevice 03:03:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:03:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:03:46 INFO - Running setup.py install for mozfile 03:03:46 INFO - Running setup.py install for mozhttpd 03:03:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Running setup.py install for mozinfo 03:03:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Running setup.py install for mozInstall 03:03:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Running setup.py install for mozleak 03:03:47 INFO - Running setup.py install for mozlog 03:03:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Running setup.py install for moznetwork 03:03:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:03:47 INFO - Running setup.py install for mozprocess 03:03:47 INFO - Running setup.py install for mozprofile 03:03:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:03:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:03:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:03:48 INFO - Running setup.py install for mozrunner 03:03:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:03:48 INFO - Running setup.py install for mozscreenshot 03:03:48 INFO - Running setup.py install for moztest 03:03:48 INFO - Running setup.py install for mozversion 03:03:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:03:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:03:48 INFO - Cleaning up... 03:03:48 INFO - Return code: 0 03:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:48 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')]} 03:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:48 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')]} 03:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:48 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:48 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 03:03:48 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 03:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:48 INFO - 'HOME': '/Users/cltbld', 03:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:48 INFO - 'LOGNAME': 'cltbld', 03:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:48 INFO - 'MOZ_NO_REMOTE': '1', 03:03:48 INFO - 'NO_EM_RESTART': '1', 03:03:48 INFO - 'PAGER': '/bin/cat', 03:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:48 INFO - 'PWD': '/builds/slave/test', 03:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:48 INFO - 'SHELL': '/bin/bash', 03:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:48 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:48 INFO - 'USER': 'cltbld', 03:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:48 INFO - 'XPC_FLAGS': '0x0', 03:03:48 INFO - 'XPC_SERVICE_NAME': '0', 03:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-vSkLrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-7SkADJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-xyFd1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-PX0wn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-icjfHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-tq1aZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-loZ36S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-NFUrZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:49 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)) 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:49 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-4psqFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-1_u2gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-pG3KX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-04d2IJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-WZrUSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-dsNwEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-4uqcZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-ju3VJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:50 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)) 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:50 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-dgW8P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:50 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)) 03:03:50 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)) 03:03:50 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)) 03:03:50 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)) 03:03:50 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)) 03:03:50 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)) 03:03:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:53 INFO - Downloading blessings-1.6.tar.gz 03:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:03:53 INFO - Installing collected packages: blessings 03:03:53 INFO - Running setup.py install for blessings 03:03:53 INFO - Successfully installed blessings 03:03:53 INFO - Cleaning up... 03:03:53 INFO - Return code: 0 03:03:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:54 INFO - Reading from file tmpfile_stdout 03:03:54 INFO - Current package versions: 03:03:54 INFO - blessings == 1.6 03:03:54 INFO - blobuploader == 1.2.4 03:03:54 INFO - docopt == 0.6.1 03:03:54 INFO - functools32 == 3.2.3-2 03:03:54 INFO - jsonschema == 2.5.1 03:03:54 INFO - manifestparser == 1.1 03:03:54 INFO - mozInstall == 1.12 03:03:54 INFO - mozcrash == 1.0 03:03:54 INFO - mozdebug == 0.1 03:03:54 INFO - mozdevice == 0.49 03:03:54 INFO - mozfile == 1.2 03:03:54 INFO - mozhttpd == 0.7 03:03:54 INFO - mozinfo == 0.9 03:03:54 INFO - mozleak == 0.1 03:03:54 INFO - mozlog == 3.4 03:03:54 INFO - moznetwork == 0.27 03:03:54 INFO - mozprocess == 0.24 03:03:54 INFO - mozprofile == 0.28 03:03:54 INFO - mozrunner == 6.13 03:03:54 INFO - mozscreenshot == 0.1 03:03:54 INFO - mozsystemmonitor == 0.3 03:03:54 INFO - moztest == 0.8 03:03:54 INFO - mozversion == 1.4 03:03:54 INFO - psutil == 3.1.1 03:03:54 INFO - requests == 1.2.3 03:03:54 INFO - wsgiref == 0.1.2 03:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 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 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:55 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 03:03:55 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 03:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:55 INFO - 'HOME': '/Users/cltbld', 03:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:55 INFO - 'LOGNAME': 'cltbld', 03:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:55 INFO - 'MOZ_NO_REMOTE': '1', 03:03:55 INFO - 'NO_EM_RESTART': '1', 03:03:55 INFO - 'PAGER': '/bin/cat', 03:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:55 INFO - 'PWD': '/builds/slave/test', 03:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:55 INFO - 'SHELL': '/bin/bash', 03:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:55 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:55 INFO - 'USER': 'cltbld', 03:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:55 INFO - 'XPC_FLAGS': '0x0', 03:03:55 INFO - 'XPC_SERVICE_NAME': '0', 03:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 INFO - Cleaning up... 03:03:55 INFO - Return code: 0 03:03:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed53d905f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, '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.f678zjEpwf/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.c5mQBlNXv3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 03:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:55 INFO - 'HOME': '/Users/cltbld', 03:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:55 INFO - 'LOGNAME': 'cltbld', 03:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:55 INFO - 'MOZ_NO_REMOTE': '1', 03:03:55 INFO - 'NO_EM_RESTART': '1', 03:03:55 INFO - 'PAGER': '/bin/cat', 03:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:55 INFO - 'PWD': '/builds/slave/test', 03:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:55 INFO - 'SHELL': '/bin/bash', 03:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:03:55 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:55 INFO - 'USER': 'cltbld', 03:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:55 INFO - 'XPC_FLAGS': '0x0', 03:03:55 INFO - 'XPC_SERVICE_NAME': '0', 03:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:03:55 INFO - Cleaning up... 03:03:55 INFO - Return code: 0 03:03:55 INFO - Running post-action listener: _resource_record_post_action 03:03:55 INFO - Running post-action listener: _start_resource_monitoring 03:03:56 INFO - Starting resource monitoring. 03:03:56 INFO - [mozharness: 2017-02-09 11:03:56.028419Z] Finished create-virtualenv step (success) 03:03:56 INFO - [mozharness: 2017-02-09 11:03:56.029304Z] Running install step. 03:03:56 INFO - Running pre-action listener: _resource_record_pre_action 03:03:56 INFO - Running main action method: install 03:03:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:56 INFO - Reading from file tmpfile_stdout 03:03:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:03:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:03:56 INFO - Reading from file tmpfile_stdout 03:03:56 INFO - Output received: 03:03:56 INFO - Usage: mozinstall [options] installer 03:03:56 INFO - Options: 03:03:56 INFO - -h, --help show this help message and exit 03:03:56 INFO - -d DEST, --destination=DEST 03:03:56 INFO - Directory to install application into. [default: 03:03:56 INFO - "/builds/slave/test"] 03:03:56 INFO - --app=APP Application being installed. [default: firefox] 03:03:56 INFO - mkdir: /builds/slave/test/build/application 03:03:56 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'] 03:03:56 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 03:04:16 INFO - Reading from file tmpfile_stdout 03:04:16 INFO - Output received: 03:04:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:04:16 INFO - Running post-action listener: _resource_record_post_action 03:04:16 INFO - [mozharness: 2017-02-09 11:04:16.364152Z] Finished install step (success) 03:04:16 INFO - [mozharness: 2017-02-09 11:04:16.364324Z] Running run-tests step. 03:04:16 INFO - Running pre-action listener: _resource_record_pre_action 03:04:16 INFO - Running main action method: run_tests 03:04:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:04:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:04:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:04:16 INFO - 2017-02-09 03:04:16.379 screenresolution[1625:7325] starting screenresolution argv=screenresolution get 03:04:16 INFO - 2017-02-09 03:04:16.381 screenresolution[1625:7325] Display 0: 1600x1200x32@60 03:04:16 INFO - 2017-02-09 03:04:16.387 screenresolution[1626:7328] starting screenresolution argv=screenresolution list 03:04:16 INFO - Available Modes on Display 0 03:04:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:04:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:04:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:04:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:04:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:04:16 INFO - Intel Iris: 03:04:16 INFO - Chipset Model: Intel Iris 03:04:16 INFO - Type: GPU 03:04:16 INFO - Bus: Built-In 03:04:16 INFO - VRAM (Dynamic, Max): 1536 MB 03:04:16 INFO - Vendor: Intel (0x8086) 03:04:16 INFO - Device ID: 0x0a2e 03:04:16 INFO - Revision ID: 0x0009 03:04:16 INFO - Displays: 03:04:16 INFO - Display: 03:04:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:04:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:04:16 INFO - Display Serial Number: 1600x1200 60 03:04:16 INFO - Main Display: Yes 03:04:16 INFO - Mirror: Off 03:04:16 INFO - Online: Yes 03:04:16 INFO - Rotation: Supported 03:04:16 INFO - Return code: 0 03:04:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:04:16 INFO - Python 2.7.3 03:04:16 INFO - Return code: 0 03:04:16 INFO - grabbing minidump binary from tooltool 03:04: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')]} 03:04:16 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 0x100a65d30>, '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 0x10098cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:04:16 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 03:04:16 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 03:04:16 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 03:04:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:16 INFO - Return code: 0 03:04:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:04:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:04:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:04:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:04:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:04:16 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/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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 03:04:16 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/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0301 --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 03:04:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f678zjEpwf/Render', 03:04:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:16 INFO - 'HOME': '/Users/cltbld', 03:04:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:16 INFO - 'LOGNAME': 'cltbld', 03:04:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:16 INFO - 'MOZ_NO_REMOTE': '1', 03:04:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:16 INFO - 'NO_EM_RESTART': '1', 03:04:16 INFO - 'PAGER': '/bin/cat', 03:04:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:16 INFO - 'PWD': '/builds/slave/test', 03:04:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:16 INFO - 'SHELL': '/bin/bash', 03:04:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5mQBlNXv3/Listeners', 03:04:16 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 03:04:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:16 INFO - 'USER': 'cltbld', 03:04:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:16 INFO - 'XPC_FLAGS': '0x0', 03:04:16 INFO - 'XPC_SERVICE_NAME': '0', 03:04:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:16 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/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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 03:04:16 INFO - mozversion application_buildid: 20170209021221 03:04:16 INFO - mozversion application_changeset: bc736e4fab076b947c7918dba41af3d015e3ad22 03:04:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:04:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:16 INFO - mozversion application_name: Firefox 03:04:16 INFO - mozversion application_remotingname: firefox-dev 03:04:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:16 INFO - mozversion application_vendor: Mozilla 03:04:16 INFO - mozversion application_version: 53.0a2 03:04:16 INFO - mozversion platform_buildid: 20170209021221 03:04:16 INFO - mozversion platform_changeset: bc736e4fab076b947c7918dba41af3d015e3ad22 03:04:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:16 INFO - mozversion platform_version: 53.0a2 03:04:16 INFO - using testdate: 1486638256 03:04:16 INFO - actual date: 1486638256 03:04:16 INFO - starting webserver on 'localhost:49240' 03:04:16 INFO - SUITE-START | Running 2 tests 03:04:16 INFO - TEST-START | dromaeo_css 03:04:16 INFO - operating with platform_type : mac_ 03:04:16 INFO - Initialising browser for dromaeo_css test... 03:04:16 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpgkSBYy/profile http://localhost:49240/getInfo.html) 03:04:19 INFO - PROCESS | 1636 | 2017-02-09 03:04:19.811 plugin-container[1638:7510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f4b, name = 'com.apple.tsm.portname' 03:04:19 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:19 INFO - PROCESS | 1636 | 2017-02-09 03:04:19.815 plugin-container[1638:7510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f4f, name = 'com.apple.CFPasteboardClient' 03:04:19 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:19 INFO - PROCESS | 1636 | 2017-02-09 03:04:19.815 plugin-container[1638:7510] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:04:19 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 03:04:19 INFO - PROCESS | 1636 | colorDepth:24 03:04:19 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 03:04:19 INFO - PROCESS | 1636 | __metrics 03:04:19 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 03:04:19 INFO - PROCESS | 1636 | 1486638259978 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/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpgkSBYy/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpgkSBYy/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpgkSBYy/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpgkSBYy/profile/extensions/talos-powers@TalosPowersService.js:55:9 03:04:20 INFO - TEST-INFO | 1636: exit 0 03:04:20 INFO - Browser initialized. 03:04:20 INFO - Running cycle 1/1 for dromaeo_css test... 03:04:20 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpgkSBYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:23 INFO - PROCESS | 1639 | 2017-02-09 03:04:23.010 plugin-container[1640:7643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 03:04:23 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:23 INFO - PROCESS | 1639 | 2017-02-09 03:04:23.011 plugin-container[1640:7643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 03:04:23 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:23 INFO - PROCESS | 1639 | 2017-02-09 03:04:23.011 plugin-container[1640:7643] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:04:32 INFO - PROCESS | 1639 | RSS: Main: 218939392 03:04:32 INFO - PROCESS | 1639 | 03:07:35 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 03:07:37 INFO - PROCESS | 1639 | RSS: Main: 235966464 03:07:37 INFO - PROCESS | 1639 | 03:09:20 INFO - PROCESS | 1639 | ************************* 03:09:20 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 03:09:20 INFO - PROCESS | 1639 | 03:09:20 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:09:20 INFO - PROCESS | 1639 | Full stack: 03:09:20 INFO - PROCESS | 1639 | ************************* 03:10:39 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 03:10:40 INFO - PROCESS | 1639 | RSS: Main: 246317056 03:10:40 INFO - PROCESS | 1639 | 03:13:42 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 03:13:43 INFO - PROCESS | 1639 | RSS: Main: 252899328 03:13:43 INFO - PROCESS | 1639 | 03:16:44 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 03:16:45 INFO - PROCESS | 1639 | RSS: Main: 249270272 03:16:45 INFO - PROCESS | 1639 | 03:19:48 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 03:19:48 INFO - PROCESS | 1639 | RSS: Main: 253284352 03:19:48 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 03:22:51 INFO - PROCESS | 1639 | RSS: Main: 254849024 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | __start_tp_report 03:22:51 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 03:22:51 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 03:22:51 INFO - PROCESS | 1639 | |i|pagename|runs| 03:22:51 INFO - PROCESS | 1639 | |0;dojo.html;3412.18107654163;3412.8122953237576;3430.3482338355725;3435.811030393329;3446.6381029991844;4828.299896515004;5792.971035144824;5837.095250236215;5837.445442682949;5847.766089356421;5796.362400135981;5847.64914105154;5856.590038697293;5861.5310775138;5877.14781356703;5351.117065684158;5374.435684253156;5376.892462150755;5388.488093631099;5407.161889907071;3956.4856568646037;4342;5435.021696094701;5435.402105768382;5440.619156659035;5252.6323157379;5274.525292723654;5413.02565538203;5418.376886658046;5435.1847222916485;4394.209042372372;5289.86775330616;5322.8137015204475;5351.384590772052;5383.623146379755;4367.8471253506295;5305.973470132663;5363.704996225206;5377.11277639189;5379.435159308295;4623.884402889921;5649.717514124277;5763.538916886639;5856.970715146397;5945.643261404286;6111.774065234695;6139.829471381233;6152.261728592553;6188.226471691039;6353.269374022;6338.207724034496;6342.4926005919415;6342.9365706342805;6346.555741098125;6346.904796428057;6003.8198854034445;6009.639421634716;6013;6017.518598512109;6031.185789918392;6267.2165979252595;6319.526035547352;6327.746890124436;6337.556371054075;6341.175647165839;6220.937790622036;6238.875222495615;6295.937040629627;6300.495960323163;6319.715612797435;6337.493000560036;6358.459530939922;6368.840778980562;6387.361263873576;6391.776287829904;6143.665407145256;6204;6218.067289906459;6266.310705822356;6301.558890877686;6322.241331040304;6341.4609758170145;6360.427561519486;6366.363363663597;6367.204099487564;5090.287359769635;5095.464976177448;5107.923381149286;5124.001639360652;5141.331626888481;4493.5281795411665;4508.797104130256;4542.931856022163;4558.452985641744;4599.517050709695;5883.823485295448;5884.764609415661;5926.733297001645;6008.639481631116;6016.518678505709;6326.620402775849;6328.525360597973;6330.145430366933;6350.745970161234;6356.77751278703;5757.539396848242;5815.360310365856;5901.055831067095;5946.910796338058;5972.850678733066;5601.831945041656;5606.243157173811;5609.943900560942;5617.21359009739;5633.605647604711;6516.152900122954;6519.152510173647;6528.955367141235;6545.410913017851;6551.541392102507;6221.626702397871;6257.405546473078;6282;6285.2457705075685;6322.36776322364;6510.707018184288;6530.281669016499;6530.412262896172;6533.18335208099;6534.052562378523;6323;6323.715432805443;6325.936740632719;6330.272018717722;6348.492120630431;5035.899282014412;6193.225846769154;6204.658743769136;6279.466245369012;6342.016987366966;4588.816447342202;6264.843378915563;6296.150019747275;6319.304876463493;6334.8733025338315;6215.34738852414;6262.968685156545;6296.307406185224;6309.085182648399;6321.399467050623;5997.55018373615;6077.756889724538;6152.50779937595;6166.660833654192;6198.783042593487;5251.501107394792;5837.474627283565;6138.388398386059;6146.139540464428;6199.3490683477585;5646.209530665792;6055.697215139314;6137.294211165595;6153.476954458921;6160.260768707783 03:22:51 INFO - PROCESS | 1639 | |1;ext.html;442.1201808401282;488.80936434790436;504.6013649217119;513.3506114764822;529.9364076310843;38151.85544433668;40671.186576268534;40776.59223407765;40829.18341633165;40905.59094409055;41904.161916761645;42479;42480.57519424805;42532.78733606335;42562.36156457655;8401.621927013268;8634.050254472004;9099.090090990898;9323.860142097874;9347.252219822432;10169.338992965471;10990.955859193364;11165.330080195214;11483.885161148406;11486;11403.42982850854;11478.942605286962;11529.308241505494;11533.65399038026;11546.422678866065;11422.25755325901;11432.371219582878;11482.770344593146;11517;11736;11435.656930292105;11446.828297575543;11461;11468.541258349656;11493.023093037102;40156.196876062604;40431.59568404308;40433.59566404328;40479.7976010121;40483.58307459225;3929.012714735522;3968.8412463501427;4022.35642297231;4038.757674539537;4132.772697501636;29582.556261656093;29964.400711985858;30171.69828301733;31185.376292474022;31787.841060794548;3241;3243;3257.218267615779;3291.4569096099117;3314.171457135716;493146.9999999964;498778.5061074708;499047;499054;504886;60540.091898620674;60778.088328675105;60867.69566152141;60901;60995.6950215255;62505.374946250864;63044;63256.73486530244;63458.68270658617;63859.6807015962;16448;16608.169591520375;16674.83325166757;16697.248623811956;16713.91643041777;11471.426428678533;11746.94126529379;12971.870281297255;13020.739585208243;13278.867211327763;19931.302404415776;21975.340739777832;22115.89420528967;22152.556948860933;22170;8931.553422328858;9223.538823058954;9224.031476694985;9283.599173862167;9322.30082743797;864.4353719767241;871.5642178910545;886.3573908915985;903.0247332880473;908.0601577367393;30624.54063189054;30627;30881;31023;31208.063758087294;1004.2969921055291;1046.215338496128;1060.0936199549428;1070.68414817629;1217.1966502108744;13373.996950228771;13712.17726936387;14525.692687658162;15409.922950385177;15920.601984950468;237299.81350093483;237675;237828;238041;238944;61125.08312375318;61841.45396365127;61997.380026200066;62110;62118.75762484725;1431.914085154894;1447.4355001549404;1447.5802017415042;1452.4045141491938;1465.0916431812132;28086.455244960907;29007.85496072506;30156.547651784804;30257.848710756305;30775.846120770148;50611;51043;51104.74447627738;51196;51325.74337128291;562500;565955;566671;567164;568227;43113.56886431221;43564.69305920827;43994;44060.559394405645;44075.559244407144;46232.30651540297;46731.76634116808;46891.06217875555;47792.7610361946;48188.75905620449;31826.204344891565;38683;39894;40106;40852.182956341305;35733.82133089318;38254.61745382622;38391.30822684981;39043;39363.015924602114;37247.81376093102;37712;37811;38145;38198.618013819505;28862.55687215589;32215.677843221267;32304;34038;34695.479567805996;18022.459326220236;22450.765207913722;22845.971931263466;23243.651345230173;23349.94925228335 03:22:51 INFO - PROCESS | 1639 | |2;jquery.html;379.74936541882346;382.27749553344165;393.3725707496543;393.9527256729193;418.5103428988086;14765.557033288991;17994.550136246602;19128.808711912876;19132.521686957833;19232.807671923278;19677.606447871032;19787.505312367197;21628.783712162873;21713.240036598723;21992.560148797016;5540;5968.67172305523;5998.670073145975;6015.879682406371;6018.037114061751;5739.196512488255;5843.824685259449;5958.076498142795;5970.522358211333;5995.010823214165;5970.164177015221;6018.187544681477;6125.5712100153005;6130.877382452349;6133.6626485543275;5105.872353191163;5645.5201307888465;6117.388261173892;6151.046587778901;6710.194776626788;5179.533841954242;5968.37332080134;6002.729877155495;6007.579469437142;6028.577999540034;25124.371890702696;25676.972921083136;26131.346716332053;26204.475910481873;26530.73469265302;2162.945926351838;2537.796976241896;2589.4303253284247;2606.387498937748;2966.1546459259225;9926.751831204205;10396.11633011195;10459.477026148663;10612.46937653122;10644.57421703131;1836.3113832312883;1859.5630026943657;1876.7935527092009;1895.043003283333;1898.6202759448026;136212;137073;138837;139036;141079.88380174307;11855.58505452305;12098.09264305163;12166.087543434278;12394.81407778884;12484.438200281009;14263.930205234648;14987.025843320149;16028.278727457293;16090.436834710728;16159.272832722556;8495.575221238912;8809.207171354608;8844.867326990101;8892.911070889339;9088.727338179866;8620.280687882956;8706.6517339307;8810.074942131112;8944.195022448012;9008.819823603491;4853.490383509751;4948.604111671129;4954.8761280968265;4965.131102057126;4992.525710057539;2027.8174964252994;2064.566441047397;2115.598036373084;2115.7355330583678;2117.925872594452;981.8674478945394;1013.3413281367023;1017.3488967061087;1017.7201269650906;1022.9438827955862;21359.997210057827;21588;21645.56708865814;21701.34895953124;21882;1033.405791669793;1036.72008557689;1046.4663021858755;1071.8177909755361;1080.3733834376044;10959.945200273947;11313;11324;11412.885871141349;11434.02810761078;428900;734066;780216;780713;805529;123026.38486807687;144799;145921.27039364947;154754;156349;781.456887463219;976.1312431935582;998.3510718033336;1005.4269066632096;1005.9748506287401;15574;17863;18752.437426877215;19062.523436913634;19152.233910643976;41844.3723344144;49123.01753964972;55007.44992550183;55158.44841551533;60478.69760651168;83848.15184815184;85625;86346;86925.56537217273;87304;6412.35876412355;8476.915230847613;8633.32255577397;8679.392442528962;8786.824263514822;9444.433333999981;10510.632127875488;12389.876101239233;12777.872221277668;13859.722805544034;9563.521823908915;10925;11494.827577586175;11589.420528973686;11659.650210493699;7420.257974202536;8756.036835947913;9396.201322887631;11472.254303470248;11923.523059077539;6043.365446628217;8444.986601607847;10078.899211007796;10512.737181570523;11829.645110646694;6938.791836244921;8490.23587877094;8656.48061116335;8865.778355540904;8923.687670931486;8629.69796057135;9924.900750992398;10310;10471.795743489596;10487.318324308895 03:22:51 INFO - PROCESS | 1639 | |3;mootools.html;1422.8150340455738;1423.7721964485677;1438.7122575484905;1443.2999995002422;1450.1734011613385;7508.9624551877305;7782.533048017123;8112.269895709385;8531.018932822719;8561.91438085619;8088.231617996281;8365.205305495983;8383.622736976835;8433;8500.489970601768;2306.527161931804;2344.0272287000957;2344.2732752846587;2346.049849810821;2352.388379021458;2065.380385884236;2333.9183128590503;2360.36270207044;2366.8224883133835;2367.348979030763;2093.769685334612;2181.040342249405;2264.6603009548535;2268.8184945204343;2273.920412785553;2001.68889377458;2273.8408311418207;2288.096202000209;2288.8855557222155;2308.2613563659634;2269.137727663477;2308.5267520158327;2326;2340.8595484270827;2345.29641107667;6935.757248496328;8303.294219991309;8336.416450848443;8357.665693372257;8428.620712067972;4224.176285624305;5206.140986737184;5216.217567364925;5224.425313215544;5225.399079105913;3456.1186897341267;3522.647735226457;3564.4296912494137;3568.928621427583;3602.945955810665;1210.4915935307104;1213.2295992045115;1268.3341245845913;1271.68207948013;1280.1231156657718;10754;10763.892361076367;10895.128389728803;10899.509522071527;10926.726831829188;4033.858814941463;4254.723442976197;4401.779911004437;4507.346434766941;4573.405457290597;7339.633018349061;7902.525848449111;8668.73993780175;8688.91311086881;8698.21716045559;5155.123628983007;5160.535551800356;5171.741412929338;5177.844664660066;5199.506046925536;4691.132140554008;4706.905861882743;4781.306710526954;4786.44955830077;4794.9280760788615;3729.533808273966;3763.1532905096683;3786.962130378716;3818.4654148419245;3819.007058164897;1095.118429664128;1169.181572898974;1170.9238899471507;1178.8231765235284;1187.5724739093919;671.7581670598678;874.7419511244199;896.9908852540891;907.2605826251583;933.8000669140122;5334.7065911374475;5351.96625282398;5505.421930697299;5660.801871934463;5791.218185544982;859.7592674051276;940.619049285027;961.5144352102144;968.4189486308159;1056.1920131099714;3352.580927384077;3726.9813650931574;3763.172102137525;3817.84728610858;3836.3094642964534;8525.062243153248;9771.364861284135;9877.209823214125;10064.043915827984;10076.395416275047;9971.202303815677;9997.700068997941;10011.49942502872;10034.548445319979;10037.69886903394;7457.7389791357045;7746.147923728386;7868.921310786934;7899.881501777478;7918.406119541058;5527.944720552743;5565.944340556704;5780.364159942319;5781.364049954585;5802.709864506842;7580.734674286374;9048.954755226181;9198.724038278862;9262.212711919563;9330.020347863376;9229.169374756304;9252.768680783034;9447;9513.66702165421;9522.619095236112;7059.152901651834;7269.890951635835;7307.41540676734;7308.488405811755;7311;7782.949301844179;7798.142204357629;7816.296533312029;7884.093329267208;7896.605169741605;6417.197850268716;7098.716051357887;7135.179454362607;7148.177959534512;7192.992980982771;5742.971285143548;6624.138861948109;7020.911758677413;7049.29507049291;7121.074260346329;5302.893942121059;6482.611043337415;6513.446357059703;6513.5114866384265;6524.510661700487;4869.293952376956;4944.777485013111;5000.749962501933;5063;5185.611079169153;3674.4488326751202;5019.723915184554;5058.747062646779;5092.414372347227;5093.312402825572 03:22:51 INFO - PROCESS | 1639 | |4;prototype.html;356.68967997841884;357.2105646521188;357.55662977907394;366.8477581803551;370.8479523395408;4156.002559385748;4312.439382880225;4503.662225333097;5259.317018554059;5706.51494622957;5391.838244852661;5541.007855757896;5565.359983601887;5566.357924412298;5624.578156638248;4342.870853578069;4346.978265108686;4396.0108975480425;4406.867793966187;4437.934895625059;3696.537932758405;3925.2906003826397;4414.271645178542;4418.204723149832;4424.933625995613;3498.492718555808;3791.9431208531896;3840.8847734567867;3988.162485877969;4200.936985945214;3165.018844158318;3965.1276719121747;4103.707332190351;4154.584541545836;4205.453291072172;3088.4286407014774;3605.4952306676823;3643.7995910224927;3649.9195458588615;3668.981655091734;5022.534451228677;5213.289089673349;5319.441458646864;5343.866403339909;5417.018491408811;4204.789760511962;4717.575418212343;4758.905451746084;4768.713877167381;4781.187198176319;5062.67092638981;5687.203791469197;5822.039363505017;5847.678377689225;5853.10768339054;3494.6155922848466;3842.51968503937;3932.7640341579595;3960.4257382679352;3971.960280397188;5330.706811125387;6057.757689692407;6099.390060993909;6116.327204007555;6135.32511423743;3407.7103446206856;3622.0039489140695;3994.9613100593474;4016.3172260715164;4057.269691455507;3467.463187548686;3474;3993.72043956926;4067.572904845008;4069.4302797608357;4203.642690371292;4213.30348576911;4758.357621721023;4765.642576806753;4780.593649539758;5520.503154716014;5914.231149950565;5921.73352199152;5964.224650795369;5982.235240604033;1143.8798926112804;1151.2631915574038;1181.8404515390484;1322.7222283320418;1324.9536266230637;785.8840446565775;854.6325080215443;879.3888247667937;889.4974339498292;894.2220268366563;4733.4852847088605;5044.158882008041;5145.588352931756;5176.197689358156;5249;5007.697998520338;5806.777238632515;5824.970875145597;5825.592208545361;5900.468957793819;4449.57729015743;4661.953380466152;5031.371078615173;5251.894962100737;5271.102403134868;2484.7142578603693;2861.121787352559;3021.879124835026;3079.6920307969026;3096.349766549005;5431.456854314616;5650.971745141248;6018.8194354169445;6049.78825741097;6063.060225665029;4648.7691054717325;5086.847394578169;5987.580869339192;6004.909926351108;6056.818295451144;5962.34414214436;5975.476253555315;5980.521558275327;6079.756809727562;6099.268087829489;4896;5391;5683.323419591313;5797.173890224566;5844.610126126751;5019.774110164978;5232.686038837682;5316.863050800047;6022.849428764316;6055.72749226277;6360.363963603788;6399.936000639934;6400.615963042233;6410.557624534443;6451.774112943528;3967.5797763364903;4026.59734026595;4054.2702313583836;4067.5525692173246;4079.4294196733877;5085.4406015337545;5264.394594621667;5332.946670533245;5681.431856814285;5932.940670593239;5225.529702326657;5436.809711660073;5647.7176141193595;5941.494972927349;5945.967556546106;5905.52755779528;5936.465718085393;5954.404559544011;5978.611390259619;5982.188371465404;4625.953740462553;5109.872253193551;5503.20203570472;5822.3304320003745;5871.354151043296;4874.878128046827;5661.669507665778;5720.2849643794525;5952.494038006818;5999.52003839683;4840.443349014768;4908.631852610997;5637.238972738792;5827;5865.677387743715 03:22:51 INFO - PROCESS | 1639 | |5;yui.html;670.1556039390367;690.5235387582568;727.2545640718266;742.3096520236181;792.7423587334116;13019.544315948944;14789;15602.843971560282;15810.367585296588;15828.287727052268;14276.214808185545;14413.909983052452;14479.782803257933;14783.852161478382;14813.037152585075;675.3347952267026;844.7803571071504;850.5194565070715;851.4082712514804;852.7143406958676;665.5441022899305;688.8691148681735;835.3484282259817;853.5817449449756;854.4744981836158;902.2150728865896;916.9128932751378;916.9403988740744;917.7889085510336;917.999380675064;894.1862904756673;909.2180724576858;910.3854897943861;911.9544022798867;912.192709452133;674.9898751518682;677.2617846547238;677.7864972533636;678.0642713055951;678.1726293921408;11917.642470725892;15261.160636165007;15845.12851793151;15866.444674436454;16102.75845862313;13879.722405551833;14249.145051296955;14320.57038288853;14331.42674293027;14333.56999290023;11508.079353651772;11596.072314214927;11653.6503904883;11778.705532361673;12119.697007574792;3620.1311685195365;3691.433509990987;3704.6110158433244;3708.2768860072297;3821.445890345912;107723;108308.37537436945;112842.87157128406;114113.85886141115;116399;10453.581856725797;10906.400147991779;10920.563177472972;10958.506867190996;10975.451227438756;22040.33878983633;22100.447488812908;22193.890305484983;22280.440369174325;22609.304302177403;7592.088949326006;7752.922470775333;7794;7853.607319633996;8000.719974800854;4239.830406783694;4253.191893540279;4306.720063195945;4367.606915377568;4379.430674012358;3034.2566071312226;3064.4330798802293;3511.7892926424497;3577.6601222884306;3602.171500554887;635.4725577770532;638.4190386748037;648.1250312078656;649.3928177154376;661.3452681844939;633.4457349818908;637.4072112934922;651.6122906870404;674.7315047710273;704.9013138160661;8366.498010119412;10000.649977250761;10311.020453056948;10369.68890933258;10370.637027703995;673.7709178879204;695.1415002471944;700.2122612061431;701.7193621640527;714.7426926306525;4340.782960852008;4445.2887537993765;4528.139653465897;4550.158220729176;4608.516105808909;92560;111408;112129.87870121194;112947;116952.41523792497;89185;94838.05161948293;97726;99368.50315748375;99883;69727;87432;87731.56134219289;88903.55548222347;90586;7217.314355136254;8285.295749861329;8693.174148455886;8791.032986371367;8806.251468624981;50382.49617503778;55936.44063559475;57079.714601428386;58247;58390.4160958385;68078.65960670363;70607;72925.6353718228;73276.6336168337;74171.62914185395;11627.186096973131;12018.158728889244;12660;12926;12926.095173337777;14443.451206783808;15039;15382.692346153239;15642.217889105272;15716.68566628684;12111.273323600612;13179.341032948507;13781.035327526977;14438.711225775636;14718.411263549766;13434.596962091153;14051.508197213458;14316.284185790877;14403.207823569805;14479.493217737328;13264.469421223042;13325.933370333474;13852.25131570387;13985.650358740706;14011.229382383659;10822.837657435302;11251.043661288883;11424.600138995096;11495.195336326711;11902.821457678316;7969.880451793112;8478.618462169341;10225.642102526375;10615.89384106149;10906.34561926287 03:22:51 INFO - PROCESS | 1639 | __end_tp_report 03:22:51 INFO - PROCESS | 1639 | __start_cc_report 03:22:51 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,379 03:22:51 INFO - PROCESS | 1639 | __end_cc_report 03:22:51 INFO - PROCESS | 1639 | __startTimestamp1486639371816__endTimestamp 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | ------- Summary: start ------- 03:22:51 INFO - PROCESS | 1639 | Number of tests: 6 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5816.25 Median:6077.76 stddev:697.48 (11.5%) stddev-sans-first:673.64 03:22:51 INFO - PROCESS | 1639 | Values: 3412.2 3412.8 3430.3 3435.8 3446.6 4828.3 5793.0 5837.1 5837.4 5847.8 5796.4 5847.6 5856.6 5861.5 5877.1 5351.1 5374.4 5376.9 5388.5 5407.2 3956.5 4342.0 5435.0 5435.4 5440.6 5252.6 5274.5 5413.0 5418.4 5435.2 4394.2 5289.9 5322.8 5351.4 5383.6 4367.8 5306.0 5363.7 5377.1 5379.4 4623.9 5649.7 5763.5 5857.0 5945.6 6111.8 6139.8 6152.3 6188.2 6353.3 6338.2 6342.5 6342.9 6346.6 6346.9 6003.8 6009.6 6013.0 6017.5 6031.2 6267.2 6319.5 6327.7 6337.6 6341.2 6220.9 6238.9 6295.9 6300.5 6319.7 6337.5 6358.5 6368.8 6387.4 6391.8 6143.7 6204.0 6218.1 6266.3 6301.6 6322.2 6341.5 6360.4 6366.4 6367.2 5090.3 5095.5 5107.9 5124.0 5141.3 4493.5 4508.8 4542.9 4558.5 4599.5 5883.8 5884.8 5926.7 6008.6 6016.5 6326.6 6328.5 6330.1 6350.7 6356.8 5757.5 5815.4 5901.1 5946.9 5972.9 5601.8 5606.2 5609.9 5617.2 5633.6 6516.2 6519.2 6529.0 6545.4 6551.5 6221.6 6257.4 6282.0 6285.2 6322.4 6510.7 6530.3 6530.4 6533.2 6534.1 6323.0 6323.7 6325.9 6330.3 6348.5 5035.9 6193.2 6204.7 6279.5 6342.0 4588.8 6264.8 6296.2 6319.3 6334.9 6215.3 6263.0 6296.3 6309.1 6321.4 5997.6 6077.8 6152.5 6166.7 6198.8 5251.5 5837.5 6138.4 6146.1 6199.3 5646.2 6055.7 6137.3 6153.5 6160.3 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:59832.43 Median:38148.43 stddev:121793.65 (319.3%) stddev-sans-first:122053.69 03:22:51 INFO - PROCESS | 1639 | Values: 442.1 488.8 504.6 513.4 529.9 38151.9 40671.2 40776.6 40829.2 40905.6 41904.2 42479.0 42480.6 42532.8 42562.4 8401.6 8634.1 9099.1 9323.9 9347.3 10169.3 10991.0 11165.3 11483.9 11486.0 11403.4 11478.9 11529.3 11533.7 11546.4 11422.3 11432.4 11482.8 11517.0 11736.0 11435.7 11446.8 11461.0 11468.5 11493.0 40156.2 40431.6 40433.6 40479.8 40483.6 3929.0 3968.8 4022.4 4038.8 4132.8 29582.6 29964.4 30171.7 31185.4 31787.8 3241.0 3243.0 3257.2 3291.5 3314.2 493147.0 498778.5 499047.0 499054.0 504886.0 60540.1 60778.1 60867.7 60901.0 60995.7 62505.4 63044.0 63256.7 63458.7 63859.7 16448.0 16608.2 16674.8 16697.2 16713.9 11471.4 11746.9 12971.9 13020.7 13278.9 19931.3 21975.3 22115.9 22152.6 22170.0 8931.6 9223.5 9224.0 9283.6 9322.3 864.4 871.6 886.4 903.0 908.1 30624.5 30627.0 30881.0 31023.0 31208.1 1004.3 1046.2 1060.1 1070.7 1217.2 13374.0 13712.2 14525.7 15409.9 15920.6 237299.8 237675.0 237828.0 238041.0 238944.0 61125.1 61841.5 61997.4 62110.0 62118.8 1431.9 1447.4 1447.6 1452.4 1465.1 28086.5 29007.9 30156.5 30257.8 30775.8 50611.0 51043.0 51104.7 51196.0 51325.7 562500.0 565955.0 566671.0 567164.0 568227.0 43113.6 43564.7 43994.0 44060.6 44075.6 46232.3 46731.8 46891.1 47792.8 48188.8 31826.2 38683.0 39894.0 40106.0 40852.2 35733.8 38254.6 38391.3 39043.0 39363.0 37247.8 37712.0 37811.0 38145.0 38198.6 28862.6 32215.7 32304.0 34038.0 34695.5 18022.5 22450.8 22846.0 23243.7 23349.9 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:39234.85 Median:2597.91 stddev:120173.00 (4625.8%) stddev-sans-first:120474.70 03:22:51 INFO - PROCESS | 1639 | Values: 379.7 382.3 393.4 394.0 418.5 14765.6 17994.6 19128.8 19132.5 19232.8 19677.6 19787.5 21628.8 21713.2 21992.6 5540.0 5968.7 5998.7 6015.9 6018.0 5739.2 5843.8 5958.1 5970.5 5995.0 5970.2 6018.2 6125.6 6130.9 6133.7 5105.9 5645.5 6117.4 6151.0 6710.2 5179.5 5968.4 6002.7 6007.6 6028.6 25124.4 25677.0 26131.3 26204.5 26530.7 2162.9 2537.8 2589.4 2606.4 2966.2 9926.8 10396.1 10459.5 10612.5 10644.6 1836.3 1859.6 1876.8 1895.0 1898.6 136212.0 137073.0 138837.0 139036.0 141079.9 11855.6 12098.1 12166.1 12394.8 12484.4 14263.9 14987.0 16028.3 16090.4 16159.3 8495.6 8809.2 8844.9 8892.9 9088.7 8620.3 8706.7 8810.1 8944.2 9008.8 4853.5 4948.6 4954.9 4965.1 4992.5 2027.8 2064.6 2115.6 2115.7 2117.9 981.9 1013.3 1017.3 1017.7 1022.9 21360.0 21588.0 21645.6 21701.3 21882.0 1033.4 1036.7 1046.5 1071.8 1080.4 10959.9 11313.0 11324.0 11412.9 11434.0 428900.0 734066.0 780216.0 780713.0 805529.0 123026.4 144799.0 145921.3 154754.0 156349.0 781.5 976.1 998.4 1005.4 1006.0 15574.0 17863.0 18752.4 19062.5 19152.2 41844.4 49123.0 55007.4 55158.4 60478.7 83848.2 85625.0 86346.0 86925.6 87304.0 6412.4 8476.9 8633.3 8679.4 8786.8 9444.4 10510.6 12389.9 12777.9 13859.7 9563.5 10925.0 11494.8 11589.4 11659.7 7420.3 8756.0 9396.2 11472.3 11923.5 6043.4 8445.0 10078.9 10512.7 11829.6 6938.8 8490.2 8656.5 8865.8 8923.7 8629.7 9924.9 10310.0 10471.8 10487.3 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5356.52 Median:5192.56 stddev:2907.46 (56.0%) stddev-sans-first:2900.59 03:22:51 INFO - PROCESS | 1639 | Values: 1422.8 1423.8 1438.7 1443.3 1450.2 7509.0 7782.5 8112.3 8531.0 8561.9 8088.2 8365.2 8383.6 8433.0 8500.5 2306.5 2344.0 2344.3 2346.0 2352.4 2065.4 2333.9 2360.4 2366.8 2367.3 2093.8 2181.0 2264.7 2268.8 2273.9 2001.7 2273.8 2288.1 2288.9 2308.3 2269.1 2308.5 2326.0 2340.9 2345.3 6935.8 8303.3 8336.4 8357.7 8428.6 4224.2 5206.1 5216.2 5224.4 5225.4 3456.1 3522.6 3564.4 3568.9 3602.9 1210.5 1213.2 1268.3 1271.7 1280.1 10754.0 10763.9 10895.1 10899.5 10926.7 4033.9 4254.7 4401.8 4507.3 4573.4 7339.6 7902.5 8668.7 8688.9 8698.2 5155.1 5160.5 5171.7 5177.8 5199.5 4691.1 4706.9 4781.3 4786.4 4794.9 3729.5 3763.2 3787.0 3818.5 3819.0 1095.1 1169.2 1170.9 1178.8 1187.6 671.8 874.7 897.0 907.3 933.8 5334.7 5352.0 5505.4 5660.8 5791.2 859.8 940.6 961.5 968.4 1056.2 3352.6 3727.0 3763.2 3817.8 3836.3 8525.1 9771.4 9877.2 10064.0 10076.4 9971.2 9997.7 10011.5 10034.5 10037.7 7457.7 7746.1 7868.9 7899.9 7918.4 5527.9 5565.9 5780.4 5781.4 5802.7 7580.7 9049.0 9198.7 9262.2 9330.0 9229.2 9252.8 9447.0 9513.7 9522.6 7059.2 7269.9 7307.4 7308.5 7311.0 7782.9 7798.1 7816.3 7884.1 7896.6 6417.2 7098.7 7135.2 7148.2 7193.0 5743.0 6624.1 7020.9 7049.3 7121.1 5302.9 6482.6 6513.4 6513.5 6524.5 4869.3 4944.8 5000.7 5063.0 5185.6 3674.4 5019.7 5058.7 5092.4 5093.3 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4639.85 Median:5127.73 stddev:1461.62 (28.5%) stddev-sans-first:1429.93 03:22:51 INFO - PROCESS | 1639 | Values: 356.7 357.2 357.6 366.8 370.8 4156.0 4312.4 4503.7 5259.3 5706.5 5391.8 5541.0 5565.4 5566.4 5624.6 4342.9 4347.0 4396.0 4406.9 4437.9 3696.5 3925.3 4414.3 4418.2 4424.9 3498.5 3791.9 3840.9 3988.2 4200.9 3165.0 3965.1 4103.7 4154.6 4205.5 3088.4 3605.5 3643.8 3649.9 3669.0 5022.5 5213.3 5319.4 5343.9 5417.0 4204.8 4717.6 4758.9 4768.7 4781.2 5062.7 5687.2 5822.0 5847.7 5853.1 3494.6 3842.5 3932.8 3960.4 3972.0 5330.7 6057.8 6099.4 6116.3 6135.3 3407.7 3622.0 3995.0 4016.3 4057.3 3467.5 3474.0 3993.7 4067.6 4069.4 4203.6 4213.3 4758.4 4765.6 4780.6 5520.5 5914.2 5921.7 5964.2 5982.2 1143.9 1151.3 1181.8 1322.7 1325.0 785.9 854.6 879.4 889.5 894.2 4733.5 5044.2 5145.6 5176.2 5249.0 5007.7 5806.8 5825.0 5825.6 5900.5 4449.6 4662.0 5031.4 5251.9 5271.1 2484.7 2861.1 3021.9 3079.7 3096.3 5431.5 5651.0 6018.8 6049.8 6063.1 4648.8 5086.8 5987.6 6004.9 6056.8 5962.3 5975.5 5980.5 6079.8 6099.3 4896.0 5391.0 5683.3 5797.2 5844.6 5019.8 5232.7 5316.9 6022.8 6055.7 6360.4 6399.9 6400.6 6410.6 6451.8 3967.6 4026.6 4054.3 4067.6 4079.4 5085.4 5264.4 5332.9 5681.4 5932.9 5225.5 5436.8 5647.7 5941.5 5946.0 5905.5 5936.5 5954.4 5978.6 5982.2 4626.0 5109.9 5503.2 5822.3 5871.4 4874.9 5661.7 5720.3 5952.5 5999.5 4840.4 4908.6 5637.2 5827.0 5865.7 03:22:51 INFO - PROCESS | 1639 | 03:22:51 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21457.67 Median:4030.64 stddev:31663.39 (785.6%) stddev-sans-first:31713.74 03:22:51 INFO - PROCESS | 1639 | Values: 670.2 690.5 727.3 742.3 792.7 13019.5 14789.0 15602.8 15810.4 15828.3 14276.2 14413.9 14479.8 14783.9 14813.0 675.3 844.8 850.5 851.4 852.7 665.5 688.9 835.3 853.6 854.5 902.2 916.9 916.9 917.8 918.0 894.2 909.2 910.4 912.0 912.2 675.0 677.3 677.8 678.1 678.2 11917.6 15261.2 15845.1 15866.4 16102.8 13879.7 14249.1 14320.6 14331.4 14333.6 11508.1 11596.1 11653.7 11778.7 12119.7 3620.1 3691.4 3704.6 3708.3 3821.4 107723.0 108308.4 112842.9 114113.9 116399.0 10453.6 10906.4 10920.6 10958.5 10975.5 22040.3 22100.4 22193.9 22280.4 22609.3 7592.1 7752.9 7794.0 7853.6 8000.7 4239.8 4253.2 4306.7 4367.6 4379.4 3034.3 3064.4 3511.8 3577.7 3602.2 635.5 638.4 648.1 649.4 661.3 633.4 637.4 651.6 674.7 704.9 8366.5 10000.6 10311.0 10369.7 10370.6 673.8 695.1 700.2 701.7 714.7 4340.8 4445.3 4528.1 4550.2 4608.5 92560.0 111408.0 112129.9 112947.0 116952.4 89185.0 94838.1 97726.0 99368.5 99883.0 69727.0 87432.0 87731.6 88903.6 90586.0 7217.3 8285.3 8693.2 8791.0 8806.3 50382.5 55936.4 57079.7 58247.0 58390.4 68078.7 70607.0 72925.6 73276.6 74171.6 11627.2 12018.2 12660.0 12926.0 12926.1 14443.5 15039.0 15382.7 15642.2 15716.7 12111.3 13179.3 13781.0 14438.7 14718.4 13434.6 14051.5 14316.3 14403.2 14479.5 13264.5 13325.9 13852.3 13985.7 14011.2 10822.8 11251.0 11424.6 11495.2 11902.8 7969.9 8478.6 10225.6 10615.9 10906.3 03:22:51 INFO - PROCESS | 1639 | -------- Summary: end -------- 03:22:51 INFO - PROCESS | 1639 | 03:22:52 INFO - TEST-INFO | 1639: exit 0 03:22:52 INFO - TEST-OK | dromaeo_css | took 1115525ms 03:22:52 INFO - TEST-START | kraken 03:22:52 INFO - operating with platform_type : mac_ 03:22:52 INFO - Initialising browser for kraken test... 03:22:52 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpduTGwL/profile http://localhost:49240/getInfo.html) 03:22:55 INFO - PROCESS | 1651 | 2017-02-09 03:22:55.443 plugin-container[1652:9934] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 03:22:55 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:55 INFO - PROCESS | 1651 | 2017-02-09 03:22:55.446 plugin-container[1652:9934] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 03:22:55 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:55 INFO - PROCESS | 1651 | 2017-02-09 03:22:55.446 plugin-container[1652:9934] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:22:55 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 03:22:55 INFO - PROCESS | 1651 | colorDepth:24 03:22:55 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 03:22:55 INFO - PROCESS | 1651 | __metrics 03:22:55 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 03:22:55 INFO - PROCESS | 1651 | 1486639375597 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/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpduTGwL/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpduTGwL/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpduTGwL/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpduTGwL/profile/extensions/talos-powers@TalosPowersService.js:55:9 03:22:56 INFO - TEST-INFO | 1651: exit 0 03:22:56 INFO - Browser initialized. 03:22:56 INFO - Running cycle 1/1 for kraken test... 03:22:56 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpduTGwL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:58 INFO - PROCESS | 1653 | 2017-02-09 03:22:58.808 plugin-container[1654:10053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 03:22:58 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:58 INFO - PROCESS | 1653 | 2017-02-09 03:22:58.808 plugin-container[1654:10053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.CFPasteboardClient' 03:22:58 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:58 INFO - PROCESS | 1653 | 2017-02-09 03:22:58.808 plugin-container[1654:10053] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:23:08 INFO - PROCESS | 1653 | RSS: Main: 218722304 03:23:08 INFO - PROCESS | 1653 | 03:23:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 03:23:12 INFO - PROCESS | 1653 | RSS: Main: 233164800 03:23:12 INFO - PROCESS | 1653 | 03:23:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 03:23:15 INFO - PROCESS | 1653 | RSS: Main: 241135616 03:23:15 INFO - PROCESS | 1653 | 03:23:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 03:23:19 INFO - PROCESS | 1653 | RSS: Main: 244854784 03:23:19 INFO - PROCESS | 1653 | 03:23:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 03:23:21 INFO - PROCESS | 1653 | RSS: Main: 246145024 03:23:21 INFO - PROCESS | 1653 | 03:23:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:23:24 INFO - PROCESS | 1653 | RSS: Main: 246247424 03:23:24 INFO - PROCESS | 1653 | 03:23:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 03:23:27 INFO - PROCESS | 1653 | RSS: Main: 249716736 03:23:27 INFO - PROCESS | 1653 | 03:23:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 03:23:31 INFO - PROCESS | 1653 | RSS: Main: 249737216 03:23:31 INFO - PROCESS | 1653 | 03:23:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 03:23:35 INFO - PROCESS | 1653 | RSS: Main: 248807424 03:23:35 INFO - PROCESS | 1653 | 03:23:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:23:37 INFO - PROCESS | 1653 | RSS: Main: 248578048 03:23:37 INFO - PROCESS | 1653 | 03:23:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:39 INFO - PROCESS | 1653 | RSS: Main: 248631296 03:23:39 INFO - PROCESS | 1653 | 03:23:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:23:42 INFO - PROCESS | 1653 | RSS: Main: 248594432 03:23:42 INFO - PROCESS | 1653 | 03:23:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:23:46 INFO - PROCESS | 1653 | RSS: Main: 248676352 03:23:46 INFO - PROCESS | 1653 | 03:23:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:23:50 INFO - PROCESS | 1653 | RSS: Main: 249462784 03:23:50 INFO - PROCESS | 1653 | 03:23:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 03:23:52 INFO - PROCESS | 1653 | RSS: Main: 250687488 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | __start_tp_report 03:23:52 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 03:23:52 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 03:23:52 INFO - PROCESS | 1653 | |i|pagename|runs| 03:23:52 INFO - PROCESS | 1653 | |0;ai-astar;115;118;118;119;120;118;117;119;119;132 03:23:52 INFO - PROCESS | 1653 | |1;audio-beat-detection;149;140;97;178;143;144;133;111;132;122 03:23:52 INFO - PROCESS | 1653 | |2;audio-dft;197;196;198;195;198;197;194;199;197;206 03:23:52 INFO - PROCESS | 1653 | |3;audio-fft;83;62;64;89;61;60;64;80;97;88 03:23:52 INFO - PROCESS | 1653 | |4;audio-oscillator;84;72;85;73;70;70;94;56;87;112 03:23:52 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;92;90;91;87;92;88;91;93;91;73 03:23:52 INFO - PROCESS | 1653 | |6;imaging-darkroom;104;98;98;98;98;96;106;96;97;96 03:23:52 INFO - PROCESS | 1653 | |7;imaging-desaturate;150;145;93;97;100;93;94;91;92;94 03:23:52 INFO - PROCESS | 1653 | |8;json-parse-financial;58;58;56;59;59;59;58;60;61;61 03:23:52 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;71;76;75;79;70;70;70;70;73;72 03:23:52 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;88;82;89;90;86;85;88;73;106;116 03:23:52 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;151;137;145;154;163;141;156;137;182;182 03:23:52 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;237;236;174;172;181;215;169;169;171;170 03:23:52 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;67;67;67;65;89;87;87;75;69 03:23:52 INFO - PROCESS | 1653 | __end_tp_report 03:23:52 INFO - PROCESS | 1653 | __start_cc_report 03:23:52 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,935 03:23:52 INFO - PROCESS | 1653 | __end_cc_report 03:23:52 INFO - PROCESS | 1653 | __startTimestamp1486639432111__endTimestamp 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | ------- Summary: start ------- 03:23:52 INFO - PROCESS | 1653 | Number of tests: 14 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:119.50 Median:119.00 stddev:4.60 (3.9%) stddev-sans-first:4.58 03:23:52 INFO - PROCESS | 1653 | Values: 115.0 118.0 118.0 119.0 120.0 118.0 117.0 119.0 119.0 132.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:143.50 stddev:22.15 (15.4%) stddev-sans-first:22.90 03:23:52 INFO - PROCESS | 1653 | Values: 149.0 140.0 97.0 178.0 143.0 144.0 133.0 111.0 132.0 122.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:197.70 Median:197.50 stddev:3.27 (1.7%) stddev-sans-first:3.46 03:23:52 INFO - PROCESS | 1653 | Values: 197.0 196.0 198.0 195.0 198.0 197.0 194.0 199.0 197.0 206.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:74.80 Median:81.50 stddev:14.02 (17.2%) stddev-sans-first:14.56 03:23:52 INFO - PROCESS | 1653 | Values: 83.0 62.0 64.0 89.0 61.0 60.0 64.0 80.0 97.0 88.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:78.50 stddev:15.63 (19.9%) stddev-sans-first:16.52 03:23:52 INFO - PROCESS | 1653 | Values: 84.0 72.0 85.0 73.0 70.0 70.0 94.0 56.0 87.0 112.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:91.00 stddev:5.85 (6.4%) stddev-sans-first:6.09 03:23:52 INFO - PROCESS | 1653 | Values: 92.0 90.0 91.0 87.0 92.0 88.0 91.0 93.0 91.0 73.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:97.50 stddev:3.47 (3.6%) stddev-sans-first:3.10 03:23:52 INFO - PROCESS | 1653 | Values: 104.0 98.0 98.0 98.0 98.0 96.0 106.0 96.0 97.0 96.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:93.00 stddev:22.63 (24.3%) stddev-sans-first:17.14 03:23:52 INFO - PROCESS | 1653 | Values: 150.0 145.0 93.0 97.0 100.0 93.0 94.0 91.0 92.0 94.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:1.52 (2.6%) stddev-sans-first:1.58 03:23:52 INFO - PROCESS | 1653 | Values: 58.0 58.0 56.0 59.0 59.0 59.0 58.0 60.0 61.0 61.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:72.50 stddev:3.13 (4.3%) stddev-sans-first:3.27 03:23:52 INFO - PROCESS | 1653 | Values: 71.0 76.0 75.0 79.0 70.0 70.0 70.0 70.0 73.0 72.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:87.00 stddev:12.18 (14.0%) stddev-sans-first:12.89 03:23:52 INFO - PROCESS | 1653 | Values: 88.0 82.0 89.0 90.0 86.0 85.0 88.0 73.0 106.0 116.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:155.00 stddev:16.61 (10.7%) stddev-sans-first:17.56 03:23:52 INFO - PROCESS | 1653 | Values: 151.0 137.0 145.0 154.0 163.0 141.0 156.0 137.0 182.0 182.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:177.50 stddev:28.38 (16.0%) stddev-sans-first:24.32 03:23:52 INFO - PROCESS | 1653 | Values: 237.0 236.0 174.0 172.0 181.0 215.0 169.0 169.0 171.0 170.0 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:72.00 stddev:9.89 (13.7%) stddev-sans-first:10.07 03:23:52 INFO - PROCESS | 1653 | Values: 66.0 67.0 67.0 67.0 65.0 89.0 87.0 87.0 75.0 69.0 03:23:52 INFO - PROCESS | 1653 | -------- Summary: end -------- 03:23:52 INFO - PROCESS | 1653 | 03:23:52 INFO - TEST-INFO | 1653: exit 0 03:23:52 INFO - TEST-OK | kraken | took 60489ms 03:23:52 INFO - SUITE-END | took 1176s 03:23:53 INFO - Completed test suite (00:19:36) 03:23:53 INFO - javascript benchmark 03:23:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7348.287952198677, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.18107654163, 3412.8122953237576, 3430.3482338355725, 3435.811030393329, 3446.6381029991844, 4828.299896515004, 5792.971035144824, 5837.095250236215, 5837.445442682949, 5847.766089356421, 5796.362400135981, 5847.64914105154, 5856.590038697293, 5861.5310775138, 5877.14781356703, 5351.117065684158, 5374.435684253156, 5376.892462150755, 5388.488093631099, 5407.161889907071, 3956.4856568646037, 4342.0, 5435.021696094701, 5435.402105768382, 5440.619156659035, 5252.6323157379, 5274.525292723654, 5413.02565538203, 5418.376886658046, 5435.1847222916485, 4394.209042372372, 5289.86775330616, 5322.8137015204475, 5351.384590772052, 5383.623146379755, 4367.8471253506295, 5305.973470132663, 5363.704996225206, 5377.11277639189, 5379.435159308295, 4623.884402889921, 5649.717514124277, 5763.538916886639, 5856.970715146397, 5945.643261404286, 6111.774065234695, 6139.829471381233, 6152.261728592553, 6188.226471691039, 6353.269374022, 6338.207724034496, 6342.4926005919415, 6342.9365706342805, 6346.555741098125, 6346.904796428057, 6003.8198854034445, 6009.639421634716, 6013.0, 6017.518598512109, 6031.185789918392, 6267.2165979252595, 6319.526035547352, 6327.746890124436, 6337.556371054075, 6341.175647165839, 6220.937790622036, 6238.875222495615, 6295.937040629627, 6300.495960323163, 6319.715612797435, 6337.493000560036, 6358.459530939922, 6368.840778980562, 6387.361263873576, 6391.776287829904, 6143.665407145256, 6204.0, 6218.067289906459, 6266.310705822356, 6301.558890877686, 6322.241331040304, 6341.4609758170145, 6360.427561519486, 6366.363363663597, 6367.204099487564, 5090.287359769635, 5095.464976177448, 5107.923381149286, 5124.001639360652, 5141.331626888481, 4493.5281795411665, 4508.797104130256, 4542.931856022163, 4558.452985641744, 4599.517050709695, 5883.823485295448, 5884.764609415661, 5926.733297001645, 6008.639481631116, 6016.518678505709, 6326.620402775849, 6328.525360597973, 6330.145430366933, 6350.745970161234, 6356.77751278703, 5757.539396848242, 5815.360310365856, 5901.055831067095, 5946.910796338058, 5972.850678733066, 5601.831945041656, 5606.243157173811, 5609.943900560942, 5617.21359009739, 5633.605647604711, 6516.152900122954, 6519.152510173647, 6528.955367141235, 6545.410913017851, 6551.541392102507, 6221.626702397871, 6257.405546473078, 6282.0, 6285.2457705075685, 6322.36776322364, 6510.707018184288, 6530.281669016499, 6530.412262896172, 6533.18335208099, 6534.052562378523, 6323.0, 6323.715432805443, 6325.936740632719, 6330.272018717722, 6348.492120630431, 5035.899282014412, 6193.225846769154, 6204.658743769136, 6279.466245369012, 6342.016987366966, 4588.816447342202, 6264.843378915563, 6296.150019747275, 6319.304876463493, 6334.8733025338315, 6215.34738852414, 6262.968685156545, 6296.307406185224, 6309.085182648399, 6321.399467050623, 5997.55018373615, 6077.756889724538, 6152.50779937595, 6166.660833654192, 6198.783042593487, 5251.501107394792, 5837.474627283565, 6138.388398386059, 6146.139540464428, 6199.3490683477585, 5646.209530665792, 6055.697215139314, 6137.294211165595, 6153.476954458921, 6160.260768707783], "value": 5773.387940030895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.1201808401282, 488.80936434790436, 504.6013649217119, 513.3506114764822, 529.9364076310843, 38151.85544433668, 40671.186576268534, 40776.59223407765, 40829.18341633165, 40905.59094409055, 41904.161916761645, 42479.0, 42480.57519424805, 42532.78733606335, 42562.36156457655, 8401.621927013268, 8634.050254472004, 9099.090090990898, 9323.860142097874, 9347.252219822432, 10169.338992965471, 10990.955859193364, 11165.330080195214, 11483.885161148406, 11486.0, 11403.42982850854, 11478.942605286962, 11529.308241505494, 11533.65399038026, 11546.422678866065, 11422.25755325901, 11432.371219582878, 11482.770344593146, 11517.0, 11736.0, 11435.656930292105, 11446.828297575543, 11461.0, 11468.541258349656, 11493.023093037102, 40156.196876062604, 40431.59568404308, 40433.59566404328, 40479.7976010121, 40483.58307459225, 3929.012714735522, 3968.8412463501427, 4022.35642297231, 4038.757674539537, 4132.772697501636, 29582.556261656093, 29964.400711985858, 30171.69828301733, 31185.376292474022, 31787.841060794548, 3241.0, 3243.0, 3257.218267615779, 3291.4569096099117, 3314.171457135716, 493146.9999999964, 498778.5061074708, 499047.0, 499054.0, 504886.0, 60540.091898620674, 60778.088328675105, 60867.69566152141, 60901.0, 60995.6950215255, 62505.374946250864, 63044.0, 63256.73486530244, 63458.68270658617, 63859.6807015962, 16448.0, 16608.169591520375, 16674.83325166757, 16697.248623811956, 16713.91643041777, 11471.426428678533, 11746.94126529379, 12971.870281297255, 13020.739585208243, 13278.867211327763, 19931.302404415776, 21975.340739777832, 22115.89420528967, 22152.556948860933, 22170.0, 8931.553422328858, 9223.538823058954, 9224.031476694985, 9283.599173862167, 9322.30082743797, 864.4353719767241, 871.5642178910545, 886.3573908915985, 903.0247332880473, 908.0601577367393, 30624.54063189054, 30627.0, 30881.0, 31023.0, 31208.063758087294, 1004.2969921055291, 1046.215338496128, 1060.0936199549428, 1070.68414817629, 1217.1966502108744, 13373.996950228771, 13712.17726936387, 14525.692687658162, 15409.922950385177, 15920.601984950468, 237299.81350093483, 237675.0, 237828.0, 238041.0, 238944.0, 61125.08312375318, 61841.45396365127, 61997.380026200066, 62110.0, 62118.75762484725, 1431.914085154894, 1447.4355001549404, 1447.5802017415042, 1452.4045141491938, 1465.0916431812132, 28086.455244960907, 29007.85496072506, 30156.547651784804, 30257.848710756305, 30775.846120770148, 50611.0, 51043.0, 51104.74447627738, 51196.0, 51325.74337128291, 562500.0, 565955.0, 566671.0, 567164.0, 568227.0, 43113.56886431221, 43564.69305920827, 43994.0, 44060.559394405645, 44075.559244407144, 46232.30651540297, 46731.76634116808, 46891.06217875555, 47792.7610361946, 48188.75905620449, 31826.204344891565, 38683.0, 39894.0, 40106.0, 40852.182956341305, 35733.82133089318, 38254.61745382622, 38391.30822684981, 39043.0, 39363.015924602114, 37247.81376093102, 37712.0, 37811.0, 38145.0, 38198.618013819505, 28862.55687215589, 32215.677843221267, 32304.0, 34038.0, 34695.479567805996, 18022.459326220236, 22450.765207913722, 22845.971931263466, 23243.651345230173, 23349.94925228335], "value": 20239.505761809665, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.74936541882346, 382.27749553344165, 393.3725707496543, 393.9527256729193, 418.5103428988086, 14765.557033288991, 17994.550136246602, 19128.808711912876, 19132.521686957833, 19232.807671923278, 19677.606447871032, 19787.505312367197, 21628.783712162873, 21713.240036598723, 21992.560148797016, 5540.0, 5968.67172305523, 5998.670073145975, 6015.879682406371, 6018.037114061751, 5739.196512488255, 5843.824685259449, 5958.076498142795, 5970.522358211333, 5995.010823214165, 5970.164177015221, 6018.187544681477, 6125.5712100153005, 6130.877382452349, 6133.6626485543275, 5105.872353191163, 5645.5201307888465, 6117.388261173892, 6151.046587778901, 6710.194776626788, 5179.533841954242, 5968.37332080134, 6002.729877155495, 6007.579469437142, 6028.577999540034, 25124.371890702696, 25676.972921083136, 26131.346716332053, 26204.475910481873, 26530.73469265302, 2162.945926351838, 2537.796976241896, 2589.4303253284247, 2606.387498937748, 2966.1546459259225, 9926.751831204205, 10396.11633011195, 10459.477026148663, 10612.46937653122, 10644.57421703131, 1836.3113832312883, 1859.5630026943657, 1876.7935527092009, 1895.043003283333, 1898.6202759448026, 136212.0, 137073.0, 138837.0, 139036.0, 141079.88380174307, 11855.58505452305, 12098.09264305163, 12166.087543434278, 12394.81407778884, 12484.438200281009, 14263.930205234648, 14987.025843320149, 16028.278727457293, 16090.436834710728, 16159.272832722556, 8495.575221238912, 8809.207171354608, 8844.867326990101, 8892.911070889339, 9088.727338179866, 8620.280687882956, 8706.6517339307, 8810.074942131112, 8944.195022448012, 9008.819823603491, 4853.490383509751, 4948.604111671129, 4954.8761280968265, 4965.131102057126, 4992.525710057539, 2027.8174964252994, 2064.566441047397, 2115.598036373084, 2115.7355330583678, 2117.925872594452, 981.8674478945394, 1013.3413281367023, 1017.3488967061087, 1017.7201269650906, 1022.9438827955862, 21359.997210057827, 21588.0, 21645.56708865814, 21701.34895953124, 21882.0, 1033.405791669793, 1036.72008557689, 1046.4663021858755, 1071.8177909755361, 1080.3733834376044, 10959.945200273947, 11313.0, 11324.0, 11412.885871141349, 11434.02810761078, 428900.0, 734066.0, 780216.0, 780713.0, 805529.0, 123026.38486807687, 144799.0, 145921.27039364947, 154754.0, 156349.0, 781.456887463219, 976.1312431935582, 998.3510718033336, 1005.4269066632096, 1005.9748506287401, 15574.0, 17863.0, 18752.437426877215, 19062.523436913634, 19152.233910643976, 41844.3723344144, 49123.01753964972, 55007.44992550183, 55158.44841551533, 60478.69760651168, 83848.15184815184, 85625.0, 86346.0, 86925.56537217273, 87304.0, 6412.35876412355, 8476.915230847613, 8633.32255577397, 8679.392442528962, 8786.824263514822, 9444.433333999981, 10510.632127875488, 12389.876101239233, 12777.872221277668, 13859.722805544034, 9563.521823908915, 10925.0, 11494.827577586175, 11589.420528973686, 11659.650210493699, 7420.257974202536, 8756.036835947913, 9396.201322887631, 11472.254303470248, 11923.523059077539, 6043.365446628217, 8444.986601607847, 10078.899211007796, 10512.737181570523, 11829.645110646694, 6938.791836244921, 8490.23587877094, 8656.48061116335, 8865.778355540904, 8923.687670931486, 8629.69796057135, 9924.900750992398, 10310.0, 10471.795743489596, 10487.318324308895], "value": 9814.616816215848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.8150340455738, 1423.7721964485677, 1438.7122575484905, 1443.2999995002422, 1450.1734011613385, 7508.9624551877305, 7782.533048017123, 8112.269895709385, 8531.018932822719, 8561.91438085619, 8088.231617996281, 8365.205305495983, 8383.622736976835, 8433.0, 8500.489970601768, 2306.527161931804, 2344.0272287000957, 2344.2732752846587, 2346.049849810821, 2352.388379021458, 2065.380385884236, 2333.9183128590503, 2360.36270207044, 2366.8224883133835, 2367.348979030763, 2093.769685334612, 2181.040342249405, 2264.6603009548535, 2268.8184945204343, 2273.920412785553, 2001.68889377458, 2273.8408311418207, 2288.096202000209, 2288.8855557222155, 2308.2613563659634, 2269.137727663477, 2308.5267520158327, 2326.0, 2340.8595484270827, 2345.29641107667, 6935.757248496328, 8303.294219991309, 8336.416450848443, 8357.665693372257, 8428.620712067972, 4224.176285624305, 5206.140986737184, 5216.217567364925, 5224.425313215544, 5225.399079105913, 3456.1186897341267, 3522.647735226457, 3564.4296912494137, 3568.928621427583, 3602.945955810665, 1210.4915935307104, 1213.2295992045115, 1268.3341245845913, 1271.68207948013, 1280.1231156657718, 10754.0, 10763.892361076367, 10895.128389728803, 10899.509522071527, 10926.726831829188, 4033.858814941463, 4254.723442976197, 4401.779911004437, 4507.346434766941, 4573.405457290597, 7339.633018349061, 7902.525848449111, 8668.73993780175, 8688.91311086881, 8698.21716045559, 5155.123628983007, 5160.535551800356, 5171.741412929338, 5177.844664660066, 5199.506046925536, 4691.132140554008, 4706.905861882743, 4781.306710526954, 4786.44955830077, 4794.9280760788615, 3729.533808273966, 3763.1532905096683, 3786.962130378716, 3818.4654148419245, 3819.007058164897, 1095.118429664128, 1169.181572898974, 1170.9238899471507, 1178.8231765235284, 1187.5724739093919, 671.7581670598678, 874.7419511244199, 896.9908852540891, 907.2605826251583, 933.8000669140122, 5334.7065911374475, 5351.96625282398, 5505.421930697299, 5660.801871934463, 5791.218185544982, 859.7592674051276, 940.619049285027, 961.5144352102144, 968.4189486308159, 1056.1920131099714, 3352.580927384077, 3726.9813650931574, 3763.172102137525, 3817.84728610858, 3836.3094642964534, 8525.062243153248, 9771.364861284135, 9877.209823214125, 10064.043915827984, 10076.395416275047, 9971.202303815677, 9997.700068997941, 10011.49942502872, 10034.548445319979, 10037.69886903394, 7457.7389791357045, 7746.147923728386, 7868.921310786934, 7899.881501777478, 7918.406119541058, 5527.944720552743, 5565.944340556704, 5780.364159942319, 5781.364049954585, 5802.709864506842, 7580.734674286374, 9048.954755226181, 9198.724038278862, 9262.212711919563, 9330.020347863376, 9229.169374756304, 9252.768680783034, 9447.0, 9513.66702165421, 9522.619095236112, 7059.152901651834, 7269.890951635835, 7307.41540676734, 7308.488405811755, 7311.0, 7782.949301844179, 7798.142204357629, 7816.296533312029, 7884.093329267208, 7896.605169741605, 6417.197850268716, 7098.716051357887, 7135.179454362607, 7148.177959534512, 7192.992980982771, 5742.971285143548, 6624.138861948109, 7020.911758677413, 7049.29507049291, 7121.074260346329, 5302.893942121059, 6482.611043337415, 6513.446357059703, 6513.5114866384265, 6524.510661700487, 4869.293952376956, 4944.777485013111, 5000.749962501933, 5063.0, 5185.611079169153, 3674.4488326751202, 5019.723915184554, 5058.747062646779, 5092.414372347227, 5093.312402825572], "value": 4364.554187050084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.68967997841884, 357.2105646521188, 357.55662977907394, 366.8477581803551, 370.8479523395408, 4156.002559385748, 4312.439382880225, 4503.662225333097, 5259.317018554059, 5706.51494622957, 5391.838244852661, 5541.007855757896, 5565.359983601887, 5566.357924412298, 5624.578156638248, 4342.870853578069, 4346.978265108686, 4396.0108975480425, 4406.867793966187, 4437.934895625059, 3696.537932758405, 3925.2906003826397, 4414.271645178542, 4418.204723149832, 4424.933625995613, 3498.492718555808, 3791.9431208531896, 3840.8847734567867, 3988.162485877969, 4200.936985945214, 3165.018844158318, 3965.1276719121747, 4103.707332190351, 4154.584541545836, 4205.453291072172, 3088.4286407014774, 3605.4952306676823, 3643.7995910224927, 3649.9195458588615, 3668.981655091734, 5022.534451228677, 5213.289089673349, 5319.441458646864, 5343.866403339909, 5417.018491408811, 4204.789760511962, 4717.575418212343, 4758.905451746084, 4768.713877167381, 4781.187198176319, 5062.67092638981, 5687.203791469197, 5822.039363505017, 5847.678377689225, 5853.10768339054, 3494.6155922848466, 3842.51968503937, 3932.7640341579595, 3960.4257382679352, 3971.960280397188, 5330.706811125387, 6057.757689692407, 6099.390060993909, 6116.327204007555, 6135.32511423743, 3407.7103446206856, 3622.0039489140695, 3994.9613100593474, 4016.3172260715164, 4057.269691455507, 3467.463187548686, 3474.0, 3993.72043956926, 4067.572904845008, 4069.4302797608357, 4203.642690371292, 4213.30348576911, 4758.357621721023, 4765.642576806753, 4780.593649539758, 5520.503154716014, 5914.231149950565, 5921.73352199152, 5964.224650795369, 5982.235240604033, 1143.8798926112804, 1151.2631915574038, 1181.8404515390484, 1322.7222283320418, 1324.9536266230637, 785.8840446565775, 854.6325080215443, 879.3888247667937, 889.4974339498292, 894.2220268366563, 4733.4852847088605, 5044.158882008041, 5145.588352931756, 5176.197689358156, 5249.0, 5007.697998520338, 5806.777238632515, 5824.970875145597, 5825.592208545361, 5900.468957793819, 4449.57729015743, 4661.953380466152, 5031.371078615173, 5251.894962100737, 5271.102403134868, 2484.7142578603693, 2861.121787352559, 3021.879124835026, 3079.6920307969026, 3096.349766549005, 5431.456854314616, 5650.971745141248, 6018.8194354169445, 6049.78825741097, 6063.060225665029, 4648.7691054717325, 5086.847394578169, 5987.580869339192, 6004.909926351108, 6056.818295451144, 5962.34414214436, 5975.476253555315, 5980.521558275327, 6079.756809727562, 6099.268087829489, 4896.0, 5391.0, 5683.323419591313, 5797.173890224566, 5844.610126126751, 5019.774110164978, 5232.686038837682, 5316.863050800047, 6022.849428764316, 6055.72749226277, 6360.363963603788, 6399.936000639934, 6400.615963042233, 6410.557624534443, 6451.774112943528, 3967.5797763364903, 4026.59734026595, 4054.2702313583836, 4067.5525692173246, 4079.4294196733877, 5085.4406015337545, 5264.394594621667, 5332.946670533245, 5681.431856814285, 5932.940670593239, 5225.529702326657, 5436.809711660073, 5647.7176141193595, 5941.494972927349, 5945.967556546106, 5905.52755779528, 5936.465718085393, 5954.404559544011, 5978.611390259619, 5982.188371465404, 4625.953740462553, 5109.872253193551, 5503.20203570472, 5822.3304320003745, 5871.354151043296, 4874.878128046827, 5661.669507665778, 5720.2849643794525, 5952.494038006818, 5999.52003839683, 4840.443349014768, 4908.631852610997, 5637.238972738792, 5827.0, 5865.677387743715], "value": 4181.835635139328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.1556039390367, 690.5235387582568, 727.2545640718266, 742.3096520236181, 792.7423587334116, 13019.544315948944, 14789.0, 15602.843971560282, 15810.367585296588, 15828.287727052268, 14276.214808185545, 14413.909983052452, 14479.782803257933, 14783.852161478382, 14813.037152585075, 675.3347952267026, 844.7803571071504, 850.5194565070715, 851.4082712514804, 852.7143406958676, 665.5441022899305, 688.8691148681735, 835.3484282259817, 853.5817449449756, 854.4744981836158, 902.2150728865896, 916.9128932751378, 916.9403988740744, 917.7889085510336, 917.999380675064, 894.1862904756673, 909.2180724576858, 910.3854897943861, 911.9544022798867, 912.192709452133, 674.9898751518682, 677.2617846547238, 677.7864972533636, 678.0642713055951, 678.1726293921408, 11917.642470725892, 15261.160636165007, 15845.12851793151, 15866.444674436454, 16102.75845862313, 13879.722405551833, 14249.145051296955, 14320.57038288853, 14331.42674293027, 14333.56999290023, 11508.079353651772, 11596.072314214927, 11653.6503904883, 11778.705532361673, 12119.697007574792, 3620.1311685195365, 3691.433509990987, 3704.6110158433244, 3708.2768860072297, 3821.445890345912, 107723.0, 108308.37537436945, 112842.87157128406, 114113.85886141115, 116399.0, 10453.581856725797, 10906.400147991779, 10920.563177472972, 10958.506867190996, 10975.451227438756, 22040.33878983633, 22100.447488812908, 22193.890305484983, 22280.440369174325, 22609.304302177403, 7592.088949326006, 7752.922470775333, 7794.0, 7853.607319633996, 8000.719974800854, 4239.830406783694, 4253.191893540279, 4306.720063195945, 4367.606915377568, 4379.430674012358, 3034.2566071312226, 3064.4330798802293, 3511.7892926424497, 3577.6601222884306, 3602.171500554887, 635.4725577770532, 638.4190386748037, 648.1250312078656, 649.3928177154376, 661.3452681844939, 633.4457349818908, 637.4072112934922, 651.6122906870404, 674.7315047710273, 704.9013138160661, 8366.498010119412, 10000.649977250761, 10311.020453056948, 10369.68890933258, 10370.637027703995, 673.7709178879204, 695.1415002471944, 700.2122612061431, 701.7193621640527, 714.7426926306525, 4340.782960852008, 4445.2887537993765, 4528.139653465897, 4550.158220729176, 4608.516105808909, 92560.0, 111408.0, 112129.87870121194, 112947.0, 116952.41523792497, 89185.0, 94838.05161948293, 97726.0, 99368.50315748375, 99883.0, 69727.0, 87432.0, 87731.56134219289, 88903.55548222347, 90586.0, 7217.314355136254, 8285.295749861329, 8693.174148455886, 8791.032986371367, 8806.251468624981, 50382.49617503778, 55936.44063559475, 57079.714601428386, 58247.0, 58390.4160958385, 68078.65960670363, 70607.0, 72925.6353718228, 73276.6336168337, 74171.62914185395, 11627.186096973131, 12018.158728889244, 12660.0, 12926.0, 12926.095173337777, 14443.451206783808, 15039.0, 15382.692346153239, 15642.217889105272, 15716.68566628684, 12111.273323600612, 13179.341032948507, 13781.035327526977, 14438.711225775636, 14718.411263549766, 13434.596962091153, 14051.508197213458, 14316.284185790877, 14403.207823569805, 14479.493217737328, 13264.469421223042, 13325.933370333474, 13852.25131570387, 13985.650358740706, 14011.229382383659, 10822.837657435302, 11251.043661288883, 11424.600138995096, 11495.195336326711, 11902.821457678316, 7969.880451793112, 8478.618462169341, 10225.642102526375, 10615.89384106149, 10906.34561926287], "value": 7520.708287526688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 118.0, 119.0, 120.0, 118.0, 117.0, 119.0, 119.0, 132.0], "value": 119.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 140.0, 97.0, 178.0, 143.0, 144.0, 133.0, 111.0, 132.0, 122.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 196.0, 198.0, 195.0, 198.0, 197.0, 194.0, 199.0, 197.0, 206.0], "value": 197.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 64.0, 89.0, 61.0, 60.0, 64.0, 80.0, 97.0, 88.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 85.0, 73.0, 70.0, 70.0, 94.0, 56.0, 87.0, 112.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 87.0, 92.0, 88.0, 91.0, 93.0, 91.0, 73.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 98.0, 98.0, 98.0, 98.0, 96.0, 106.0, 96.0, 97.0, 96.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 145.0, 93.0, 97.0, 100.0, 93.0, 94.0, 91.0, 92.0, 94.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 59.0, 59.0, 59.0, 58.0, 60.0, 61.0, 61.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 75.0, 79.0, 70.0, 70.0, 70.0, 70.0, 73.0, 72.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 89.0, 90.0, 86.0, 85.0, 88.0, 73.0, 106.0, 116.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 137.0, 145.0, 154.0, 163.0, 141.0, 156.0, 137.0, 182.0, 182.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [237.0, 236.0, 174.0, 172.0, 181.0, 215.0, 169.0, 169.0, 171.0, 170.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 65.0, 89.0, 87.0, 87.0, 75.0, 69.0], "value": 73.9, "unit": "score"}]}]} 03:23:53 INFO - Return code: 0 03:23:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:23:53 ERROR - # TBPL SUCCESS # 03:23:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:23:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:23:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:23:53 INFO - 2017-02-09 03:23:53.447 screenresolution[1658:10434] starting screenresolution argv=screenresolution get 03:23:53 INFO - 2017-02-09 03:23:53.450 screenresolution[1658:10434] Display 0: 1600x1200x32@60 03:23:53 INFO - 2017-02-09 03:23:53.456 screenresolution[1659:10437] starting screenresolution argv=screenresolution list 03:23:53 INFO - Available Modes on Display 0 03:23:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:23:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:23:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:23:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:23:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:23:53 INFO - Intel Iris: 03:23:53 INFO - Chipset Model: Intel Iris 03:23:53 INFO - Type: GPU 03:23:53 INFO - Bus: Built-In 03:23:53 INFO - VRAM (Dynamic, Max): 1536 MB 03:23:53 INFO - Vendor: Intel (0x8086) 03:23:53 INFO - Device ID: 0x0a2e 03:23:53 INFO - Revision ID: 0x0009 03:23:53 INFO - Displays: 03:23:53 INFO - Display: 03:23:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:23:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:23:53 INFO - Display Serial Number: 1600x1200 60 03:23:53 INFO - Main Display: Yes 03:23:53 INFO - Mirror: Off 03:23:53 INFO - Online: Yes 03:23:53 INFO - Rotation: Supported 03:23:53 INFO - Return code: 0 03:23:53 INFO - Running post-action listener: _resource_record_post_action 03:23:53 INFO - [mozharness: 2017-02-09 11:23:53.692485Z] Finished run-tests step (success) 03:23:53 INFO - Running post-run listener: _resource_record_post_run 03:23:53 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38828544; Write bytes: 513760768; Read time: 247; Write time: 1631 03:23:53 INFO - TinderboxPrint: CPU usage
54.2% 03:23:53 INFO - TinderboxPrint: I/O read bytes / time
38,828,544 / 247 03:23:53 INFO - TinderboxPrint: I/O write bytes / time
513,760,768 / 1,631 03:23:53 INFO - TinderboxPrint: CPU idle
2,192.6 (45.8%) 03:23:53 INFO - TinderboxPrint: CPU system
962.9 (20.1%) 03:23:53 INFO - TinderboxPrint: CPU user
1,634.2 (34.1%) 03:23:53 INFO - TinderboxPrint: Swap in / out
246,886,400 / 0 03:23:53 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205402624; Write bytes: 202610688; Read time: 15684; Write time: 454 03:23:53 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36743680; Write bytes: 300189184; Read time: 228; Write time: 1141 03:23:54 INFO - Running post-run listener: _upload_blobber_files 03:23:54 INFO - Blob upload gear active. 03:23:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:23:54 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 03:23:54 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'] 03:23:54 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 03:23:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:55 INFO - (blobuploader) - INFO - Done attempting. 03:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:56 INFO - (blobuploader) - INFO - Done attempting. 03:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:57 INFO - (blobuploader) - INFO - Done attempting. 03:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:00 INFO - (blobuploader) - INFO - Done attempting. 03:24:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:24:00 INFO - Return code: 0 03:24:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:24:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:24:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dec5eb4f94fc8a684e9384f5095608f4161a14fd83f6ffe7790201a9c98819da8fc93a8cbe91dc4400c20a055ec43f1b32493fd72d7e1aa98efbc23d003daca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ced7edfccce893784735629ab1836ede8bda260a7d0c4cdf7997ebe7e0a683331a2add0c464d60c46ad77f5ade336b447fe184378d02833923487c0fcf64a24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c282d1ccccb07066fb9aa170f4000f994261ad45da036fc5c40ae7875e6f32ab3aaf47011fe99a8356d89752e54e44b62967995c212584833e2d75cfff50a0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7dbd9182222986dd82c2e450213b958d85dddcce6f66888c88ae0050eb71555327b5f8623d4076bfbe190e72675c41288eb7f14cd3a6f07f066735746aefe9"} 03:24:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:24:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:24:00 INFO - Contents: 03:24:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dec5eb4f94fc8a684e9384f5095608f4161a14fd83f6ffe7790201a9c98819da8fc93a8cbe91dc4400c20a055ec43f1b32493fd72d7e1aa98efbc23d003daca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ced7edfccce893784735629ab1836ede8bda260a7d0c4cdf7997ebe7e0a683331a2add0c464d60c46ad77f5ade336b447fe184378d02833923487c0fcf64a24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c282d1ccccb07066fb9aa170f4000f994261ad45da036fc5c40ae7875e6f32ab3aaf47011fe99a8356d89752e54e44b62967995c212584833e2d75cfff50a0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7dbd9182222986dd82c2e450213b958d85dddcce6f66888c88ae0050eb71555327b5f8623d4076bfbe190e72675c41288eb7f14cd3a6f07f066735746aefe9"} 03:24:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:24:00 INFO - Copying logs to upload dir... 03:24:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:24:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.965643 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-09 03:24:00.362309) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 03:24:00.365762) ========= 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.f678zjEpwf/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.c5mQBlNXv3/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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/0dec5eb4f94fc8a684e9384f5095608f4161a14fd83f6ffe7790201a9c98819da8fc93a8cbe91dc4400c20a055ec43f1b32493fd72d7e1aa98efbc23d003daca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ced7edfccce893784735629ab1836ede8bda260a7d0c4cdf7997ebe7e0a683331a2add0c464d60c46ad77f5ade336b447fe184378d02833923487c0fcf64a24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c282d1ccccb07066fb9aa170f4000f994261ad45da036fc5c40ae7875e6f32ab3aaf47011fe99a8356d89752e54e44b62967995c212584833e2d75cfff50a0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7dbd9182222986dd82c2e450213b958d85dddcce6f66888c88ae0050eb71555327b5f8623d4076bfbe190e72675c41288eb7f14cd3a6f07f066735746aefe9"} build_url:https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/JfOpVm4fTqG-qprOAJv3iA/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/0dec5eb4f94fc8a684e9384f5095608f4161a14fd83f6ffe7790201a9c98819da8fc93a8cbe91dc4400c20a055ec43f1b32493fd72d7e1aa98efbc23d003daca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ced7edfccce893784735629ab1836ede8bda260a7d0c4cdf7997ebe7e0a683331a2add0c464d60c46ad77f5ade336b447fe184378d02833923487c0fcf64a24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c282d1ccccb07066fb9aa170f4000f994261ad45da036fc5c40ae7875e6f32ab3aaf47011fe99a8356d89752e54e44b62967995c212584833e2d75cfff50a0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7dbd9182222986dd82c2e450213b958d85dddcce6f66888c88ae0050eb71555327b5f8623d4076bfbe190e72675c41288eb7f14cd3a6f07f066735746aefe9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 03:24:00.400998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:24:00.401338) ========= 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.f678zjEpwf/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.c5mQBlNXv3/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.005039 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:24:00.450155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 03:24:00.450473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 03:24:00.450811) ========= ========= Total master_lag: 0.19 =========