builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0341 starttime: 1486632824.26 results: success (0) buildid: 20170209004121 builduid: 52e397d362ae4cdd9f1b63e705284348 revision: eae7e45deb55defb86c7c30fdfcf20c5d017b98d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:44.258667) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:44.259133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:44.259442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:44.286950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-09 01:33:44.287610) ========= 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.iMVgPLbpNT/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.zpujSqvYKE/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:33:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2017-02-09 01:33:44 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126099 ========= master_lag: 2.98 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-09 01:33:47.395822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:47.396215) ========= 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.iMVgPLbpNT/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.zpujSqvYKE/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.026303 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:47.452180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-09 01:33:47.453049) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev eae7e45deb55defb86c7c30fdfcf20c5d017b98d --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 eae7e45deb55defb86c7c30fdfcf20c5d017b98d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iMVgPLbpNT/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.zpujSqvYKE/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:33:47,554 truncating revision to first 12 chars 2017-02-09 01:33:47,554 Setting DEBUG logging. 2017-02-09 01:33:47,554 attempt 1/10 2017-02-09 01:33:47,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/eae7e45deb55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 01:33:49,441 unpacking tar archive at: mozilla-aurora-eae7e45deb55/testing/mozharness/ program finished with exit code 0 elapsedTime=2.170386 ========= master_lag: 1.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-09 01:33:50.970694) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:50.971082) ========= script_repo_revision: eae7e45deb55defb86c7c30fdfcf20c5d017b98d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:50.972015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:50.972326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 01:33:50.997123) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-09 01:33:50.998020) ========= /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.iMVgPLbpNT/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.zpujSqvYKE/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:33:51 INFO - MultiFileLogger online at 20170209 01:33:51 in /builds/slave/test 01:33:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:33:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:33:51 INFO - {'append_to_log': False, 01:33:51 INFO - 'base_work_dir': '/builds/slave/test', 01:33:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:33:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:33:51 INFO - 'branch': 'Mozilla-Aurora', 01:33:51 INFO - 'buildbot_json_path': 'buildprops.json', 01:33:51 INFO - 'config_files': ('talos/mac_config.py',), 01:33:51 INFO - 'default_actions': ('clobber', 01:33:51 INFO - 'read-buildbot-config', 01:33:51 INFO - 'download-and-extract', 01:33:51 INFO - 'populate-webroot', 01:33:51 INFO - 'create-virtualenv', 01:33:51 INFO - 'install', 01:33:51 INFO - 'run-tests'), 01:33:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:33:51 INFO - 'download_minidump_stackwalk': True, 01:33:51 INFO - 'download_symbols': 'ondemand', 01:33:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:33:51 INFO - 'tooltool.py': '/tools/tooltool.py', 01:33:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:33:51 INFO - '/tools/misc-python/virtualenv.py')}, 01:33:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:33:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:33:51 INFO - 'installer_path': 'installer.exe', 01:33:51 INFO - 'log_level': 'info', 01:33:51 INFO - 'log_name': 'talos', 01:33:51 INFO - 'log_to_console': True, 01:33:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:33:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:33:51 INFO - 'opt_config_files': (), 01:33:51 INFO - 'pip_index': False, 01:33:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:51 INFO - 'cmd': ('bash', 01:33:51 INFO - '-c', 01:33:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:51 INFO - 'enabled': True, 01:33:51 INFO - 'halt_on_failure': False, 01:33:51 INFO - 'name': 'check_screen_resolution'},), 01:33:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:51 INFO - 'cmd': ('bash', 01:33:51 INFO - '-c', 01:33:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:51 INFO - 'enabled': True, 01:33:51 INFO - 'halt_on_failure': False, 01:33:51 INFO - 'name': 'check_screen_resolution'},), 01:33:51 INFO - 'run_cmd_checks_enabled': True, 01:33:51 INFO - 'sps_profile': False, 01:33:51 INFO - 'sps_profile_interval': 0, 01:33:51 INFO - 'suite': 'dromaeojs-e10s', 01:33:51 INFO - 'system_bits': '32', 01:33:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:33:51 INFO - 'title': 't-yosemite-r7-0341', 01:33:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:33:51 INFO - 'use_talos_json': True, 01:33:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:33:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:33:51 INFO - 'work_dir': 'build'} 01:33:51 INFO - [mozharness: 2017-02-09 09:33:51.210260Z] Running clobber step. 01:33:51 INFO - Running pre-action listener: _resource_record_pre_action 01:33:51 INFO - Running main action method: clobber 01:33:51 INFO - rmtree: /builds/slave/test/build 01:33:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:33:53 INFO - Running post-action listener: _resource_record_post_action 01:33:53 INFO - [mozharness: 2017-02-09 09:33:53.790724Z] Finished clobber step (success) 01:33:53 INFO - [mozharness: 2017-02-09 09:33:53.790848Z] Running read-buildbot-config step. 01:33:53 INFO - Running pre-action listener: _resource_record_pre_action 01:33:53 INFO - Running main action method: read_buildbot_config 01:33:53 INFO - Using buildbot properties: 01:33:53 INFO - { 01:33:53 INFO - "project": "", 01:33:53 INFO - "product": "firefox", 01:33:53 INFO - "script_repo_revision": "production", 01:33:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:33:53 INFO - "repository": "", 01:33:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:33:53 INFO - "buildid": "20170209004121", 01:33:53 INFO - "pgo_build": "False", 01:33:53 INFO - "basedir": "/builds/slave/test", 01:33:53 INFO - "buildnumber": 50, 01:33:53 INFO - "slavename": "t-yosemite-r7-0341", 01:33:53 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:33:53 INFO - "platform": "yosemite_r7", 01:33:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:33:53 INFO - "branch": "mozilla-aurora", 01:33:53 INFO - "repo_path": "releases/mozilla-aurora", 01:33:53 INFO - "revision": "eae7e45deb55defb86c7c30fdfcf20c5d017b98d", 01:33:53 INFO - "stage_platform": "macosx64", 01:33:53 INFO - "builduid": "52e397d362ae4cdd9f1b63e705284348", 01:33:53 INFO - "slavebuilddir": "test" 01:33:53 INFO - } 01:33:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 01:33:53 INFO - Running post-action listener: _resource_record_post_action 01:33:53 INFO - [mozharness: 2017-02-09 09:33:53.794155Z] Finished read-buildbot-config step (success) 01:33:53 INFO - [mozharness: 2017-02-09 09:33:53.794265Z] Running download-and-extract step. 01:33:53 INFO - Running pre-action listener: _resource_record_pre_action 01:33:53 INFO - Running main action method: download_and_extract 01:33:53 INFO - mkdir: /builds/slave/test/build/tests 01:33:53 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')]} 01:33:53 INFO - trying https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 01:33:53 INFO - Downloading https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/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 01:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/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 01:33:54 INFO - Downloaded 1199 bytes. 01:33:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:33:54 INFO - Using the following test package requirements: 01:33:54 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:33:54 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 01:33:54 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 01:33:54 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'jsshell-mac.zip'], 01:33:54 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 01:33:54 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:33:54 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 01:33:54 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 01:33:54 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 01:33:54 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:33:54 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 01:33:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:33:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:33:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:33:54 INFO - Fetch https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:33:55 INFO - Expected file size: 16357990 01:33:55 INFO - Obtained file size: 16357990 01:34:02 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 01:34:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:34:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:34:02 INFO - Fetch https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:34:03 INFO - Expected file size: 16357990 01:34:03 INFO - Obtained file size: 16357990 01:34:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 01:34:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:34:10 INFO - Fetch https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 01:34:10 INFO - Expected file size: 14403485 01:34:10 INFO - Obtained file size: 14403485 01:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:11 INFO - trying https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:34:11 INFO - Downloading https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 01:34:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/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 01:34:13 INFO - Downloaded 73818091 bytes. 01:34:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:34:13 INFO - mkdir: /builds/slave/test/properties 01:34:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:13 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:13 INFO - Contents: 01:34:13 INFO - build_url:https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:34:13 INFO - Running post-action listener: _resource_record_post_action 01:34:13 INFO - Running post-action listener: set_extra_try_arguments 01:34:13 INFO - [mozharness: 2017-02-09 09:34:13.980852Z] Finished download-and-extract step (success) 01:34:13 INFO - [mozharness: 2017-02-09 09:34:13.980972Z] Running populate-webroot step. 01:34:13 INFO - Running pre-action listener: _resource_record_pre_action 01:34:13 INFO - Running main action method: populate_webroot 01:34:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:13 INFO - '--tppagecycles', 01:34:13 INFO - '7'], 01:34:13 INFO - 'tests': ['tsvgm']}}, 01:34:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:34:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:34:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:34:13 INFO - 'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:34:13 INFO - 'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['damp', 'tps']}, 01:34:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:34:13 INFO - 'tests': ['damp', 'tps']}, 01:34:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['dromaeo_dom']}, 01:34:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['basic_compositor_video']}, 01:34:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:34:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['a11yr', 01:34:13 INFO - 'ts_paint', 01:34:13 INFO - 'tpaint', 01:34:13 INFO - 'sessionrestore', 01:34:13 INFO - 'sessionrestore_no_auto_restore', 01:34:13 INFO - 'tabpaint']}, 01:34:13 INFO - 'other-e10s': {'tests': ['a11yr', 01:34:13 INFO - 'ts_paint', 01:34:13 INFO - 'tpaint', 01:34:13 INFO - 'sessionrestore', 01:34:13 INFO - 'sessionrestore_no_auto_restore', 01:34:13 INFO - 'tabpaint']}, 01:34:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:34:13 INFO - 'ts_paint', 01:34:13 INFO - 'tpaint', 01:34:13 INFO - 'sessionrestore', 01:34:13 INFO - 'sessionrestore_no_auto_restore', 01:34:13 INFO - 'tabpaint']}, 01:34:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:34:13 INFO - 'ts_paint', 01:34:13 INFO - 'tpaint', 01:34:13 INFO - 'sessionrestore', 01:34:13 INFO - 'sessionrestore_no_auto_restore', 01:34:13 INFO - 'tabpaint']}, 01:34:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['a11yr', 01:34:13 INFO - 'ts_paint', 01:34:13 INFO - 'tpaint', 01:34:13 INFO - 'sessionrestore', 01:34:13 INFO - 'sessionrestore_no_auto_restore', 01:34:13 INFO - 'tabpaint']}, 01:34:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['a11yr', 01:34:13 INFO - 'ts_paint', 01:34:13 INFO - 'tpaint', 01:34:13 INFO - 'sessionrestore', 01:34:13 INFO - 'sessionrestore_no_auto_restore', 01:34:13 INFO - 'tabpaint']}, 01:34:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['tsvgx', 01:34:13 INFO - 'tsvgr_opacity', 01:34:13 INFO - 'tart', 01:34:13 INFO - 'tscrollx', 01:34:13 INFO - 'cart', 01:34:13 INFO - 'tsvg_static']}, 01:34:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:34:13 INFO - 'tsvgr_opacity', 01:34:13 INFO - 'tart', 01:34:13 INFO - 'tscrollx', 01:34:13 INFO - 'cart', 01:34:13 INFO - 'tsvg_static']}, 01:34:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:34:13 INFO - 'talos_options': ['--disable-e10s'], 01:34:13 INFO - 'tests': ['tp5o']}, 01:34:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:34:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:34:13 INFO - 'talos_options': ['--disable-e10s', 01:34:13 INFO - '--xperf_path', 01:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:13 INFO - 'tests': ['tp5n']}, 01:34:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:34:13 INFO - 'talos_options': ['--xperf_path', 01:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:13 INFO - 'tests': ['tp5n']}}, 01:34:13 INFO - 'talos.zip': {'path': '', 01:34:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:13 INFO - Running post-action listener: _resource_record_post_action 01:34:13 INFO - [mozharness: 2017-02-09 09:34:13.999897Z] Finished populate-webroot step (success) 01:34:14 INFO - [mozharness: 2017-02-09 09:34:14.000008Z] Running create-virtualenv step. 01:34:14 INFO - Running pre-action listener: _resource_record_pre_action 01:34:14 INFO - Running main action method: create_virtualenv 01:34:14 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:14 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 01:34:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:14 INFO - Using real prefix '/tools/python27' 01:34:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:14 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:17 INFO - Installing pip.................done. 01:34:17 INFO - Return code: 0 01:34:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:34:18 INFO - Reading from file tmpfile_stdout 01:34:18 INFO - Output received: 01:34:18 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) 01:34:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:34:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:18 INFO - 'HOME': '/Users/cltbld', 01:34:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:18 INFO - 'LOGNAME': 'cltbld', 01:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:18 INFO - 'MOZ_NO_REMOTE': '1', 01:34:18 INFO - 'NO_EM_RESTART': '1', 01:34:18 INFO - 'PAGER': '/bin/cat', 01:34:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:18 INFO - 'PWD': '/builds/slave/test', 01:34:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:18 INFO - 'SHELL': '/bin/bash', 01:34:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:18 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:18 INFO - 'USER': 'cltbld', 01:34:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:18 INFO - 'XPC_FLAGS': '0x0', 01:34:18 INFO - 'XPC_SERVICE_NAME': '0', 01:34:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:18 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 01:34:18 INFO - Cleaning up... 01:34:18 INFO - Return code: 0 01:34:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:34:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:18 INFO - 'HOME': '/Users/cltbld', 01:34:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:18 INFO - 'LOGNAME': 'cltbld', 01:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:18 INFO - 'MOZ_NO_REMOTE': '1', 01:34:18 INFO - 'NO_EM_RESTART': '1', 01:34:18 INFO - 'PAGER': '/bin/cat', 01:34:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:18 INFO - 'PWD': '/builds/slave/test', 01:34:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:18 INFO - 'SHELL': '/bin/bash', 01:34:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:18 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:18 INFO - 'USER': 'cltbld', 01:34:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:18 INFO - 'XPC_FLAGS': '0x0', 01:34:18 INFO - 'XPC_SERVICE_NAME': '0', 01:34:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:18 INFO - Downloading/unpacking psutil>=3.1.1 01:34:18 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 01:34:18 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 01:34:18 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 01:34:18 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 01:34:18 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 01:34:18 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 01:34:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:34:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:22 INFO - Installing collected packages: psutil 01:34:22 INFO - Running setup.py install for psutil 01:34:22 INFO - building 'psutil._psutil_osx' extension 01:34:22 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 01:34:22 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 01:34:22 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 01:34:22 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 01:34:22 INFO - building 'psutil._psutil_posix' extension 01:34:22 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 01:34:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:34:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:34:22 INFO - ^ 01:34:22 INFO - 1 warning generated. 01:34:23 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 01:34:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:23 INFO - Successfully installed psutil 01:34:23 INFO - Cleaning up... 01:34:23 INFO - Return code: 0 01:34:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:34:23 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')]} 01:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:23 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')]} 01:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:23 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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:23 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 01:34:23 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 01:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:23 INFO - 'HOME': '/Users/cltbld', 01:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:23 INFO - 'LOGNAME': 'cltbld', 01:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:23 INFO - 'MOZ_NO_REMOTE': '1', 01:34:23 INFO - 'NO_EM_RESTART': '1', 01:34:23 INFO - 'PAGER': '/bin/cat', 01:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:23 INFO - 'PWD': '/builds/slave/test', 01:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:23 INFO - 'SHELL': '/bin/bash', 01:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:23 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:23 INFO - 'USER': 'cltbld', 01:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:23 INFO - 'XPC_FLAGS': '0x0', 01:34:23 INFO - 'XPC_SERVICE_NAME': '0', 01:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:34:23 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 01:34:23 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 01:34:23 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 01:34:23 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 01:34:23 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 01:34:23 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 01:34:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:34:26 INFO - Installing collected packages: mozsystemmonitor 01:34:26 INFO - Running setup.py install for mozsystemmonitor 01:34:26 INFO - Successfully installed mozsystemmonitor 01:34:26 INFO - Cleaning up... 01:34:26 INFO - Return code: 0 01:34:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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', '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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:34: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 jsonschema==2.5.1 01:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:26 INFO - 'HOME': '/Users/cltbld', 01:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:26 INFO - 'LOGNAME': 'cltbld', 01:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:26 INFO - 'MOZ_NO_REMOTE': '1', 01:34:26 INFO - 'NO_EM_RESTART': '1', 01:34:26 INFO - 'PAGER': '/bin/cat', 01:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:26 INFO - 'PWD': '/builds/slave/test', 01:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:26 INFO - 'SHELL': '/bin/bash', 01:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:26 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:26 INFO - 'USER': 'cltbld', 01:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:26 INFO - 'XPC_FLAGS': '0x0', 01:34:26 INFO - 'XPC_SERVICE_NAME': '0', 01:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:26 INFO - Downloading/unpacking jsonschema==2.5.1 01:34:26 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 01:34:26 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 01:34:26 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 01:34:26 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 01:34:26 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 01:34:26 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 01:34:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:34:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:29 INFO - Downloading functools32-3.2.3-2.tar.gz 01:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:34:29 INFO - warning: no files found matching '*.txt' 01:34:29 INFO - no previously-included directories found matching 'build' 01:34:29 INFO - no previously-included directories found matching 'dist' 01:34:29 INFO - no previously-included directories found matching '.git*' 01:34:29 INFO - Installing collected packages: jsonschema, functools32 01:34:29 INFO - Running setup.py install for functools32 01:34:30 INFO - warning: no files found matching '*.txt' 01:34:30 INFO - no previously-included directories found matching 'build' 01:34:30 INFO - no previously-included directories found matching 'dist' 01:34:30 INFO - no previously-included directories found matching '.git*' 01:34:30 INFO - Successfully installed jsonschema functools32 01:34:30 INFO - Cleaning up... 01:34:30 INFO - Return code: 0 01:34:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:34:30 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')]} 01:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 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')]} 01:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:30 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 01:34:30 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 01:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:30 INFO - 'HOME': '/Users/cltbld', 01:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:30 INFO - 'LOGNAME': 'cltbld', 01:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:30 INFO - 'MOZ_NO_REMOTE': '1', 01:34:30 INFO - 'NO_EM_RESTART': '1', 01:34:30 INFO - 'PAGER': '/bin/cat', 01:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:30 INFO - 'PWD': '/builds/slave/test', 01:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:30 INFO - 'SHELL': '/bin/bash', 01:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:30 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:30 INFO - 'USER': 'cltbld', 01:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:30 INFO - 'XPC_FLAGS': '0x0', 01:34:30 INFO - 'XPC_SERVICE_NAME': '0', 01:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:34:30 INFO - Cleaning up... 01:34:30 INFO - Return code: 0 01:34:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:34:30 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')]} 01:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 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')]} 01:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:30 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 01:34:30 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 01:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:30 INFO - 'HOME': '/Users/cltbld', 01:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:30 INFO - 'LOGNAME': 'cltbld', 01:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:30 INFO - 'MOZ_NO_REMOTE': '1', 01:34:30 INFO - 'NO_EM_RESTART': '1', 01:34:30 INFO - 'PAGER': '/bin/cat', 01:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:30 INFO - 'PWD': '/builds/slave/test', 01:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:30 INFO - 'SHELL': '/bin/bash', 01:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:30 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:30 INFO - 'USER': 'cltbld', 01:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:30 INFO - 'XPC_FLAGS': '0x0', 01:34:30 INFO - 'XPC_SERVICE_NAME': '0', 01:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:30 INFO - Downloading/unpacking blobuploader==1.2.4 01:34:30 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 01:34:30 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 01:34:30 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 01:34:30 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 01:34:30 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 01:34:30 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 01:34:33 INFO - Downloading blobuploader-1.2.4.tar.gz 01:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:34:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:34:33 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 01:34:33 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 01:34:33 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 01:34:33 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 01:34:33 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 01:34:33 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 01:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:34:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:34:34 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 01:34:34 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 01:34:34 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 01:34:34 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 01:34:34 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 01:34:34 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 01:34:34 INFO - Downloading docopt-0.6.1.tar.gz 01:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:34:34 INFO - Installing collected packages: blobuploader, requests, docopt 01:34:34 INFO - Running setup.py install for blobuploader 01:34:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:34:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:34:34 INFO - Running setup.py install for requests 01:34:35 INFO - Running setup.py install for docopt 01:34:35 INFO - Successfully installed blobuploader requests docopt 01:34:35 INFO - Cleaning up... 01:34:35 INFO - Return code: 0 01:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:35 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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:35 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 01:34:35 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 01:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:35 INFO - 'HOME': '/Users/cltbld', 01:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:35 INFO - 'LOGNAME': 'cltbld', 01:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:35 INFO - 'MOZ_NO_REMOTE': '1', 01:34:35 INFO - 'NO_EM_RESTART': '1', 01:34:35 INFO - 'PAGER': '/bin/cat', 01:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:35 INFO - 'PWD': '/builds/slave/test', 01:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:35 INFO - 'SHELL': '/bin/bash', 01:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:35 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:35 INFO - 'USER': 'cltbld', 01:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:35 INFO - 'XPC_FLAGS': '0x0', 01:34:35 INFO - 'XPC_SERVICE_NAME': '0', 01:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:35 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Dw8Mgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:35 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-03nMPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-riRPDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-ItO1Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Oqkd8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-GXEkse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-XmI6fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-6f12UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-qkq3RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-RSU7JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:36 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-WEfkir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:37 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-11o9nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:37 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-n0mg5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:37 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-a9fcHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:37 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Hs2CoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:37 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Urs7vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:37 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Y_Og9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:34:37 INFO - Running setup.py install for manifestparser 01:34:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:34:37 INFO - Running setup.py install for mozcrash 01:34:37 INFO - Running setup.py install for mozdebug 01:34:38 INFO - Running setup.py install for mozdevice 01:34:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Running setup.py install for mozfile 01:34:38 INFO - Running setup.py install for mozhttpd 01:34:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Running setup.py install for mozinfo 01:34:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Running setup.py install for mozInstall 01:34:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:34:38 INFO - Running setup.py install for mozleak 01:34:38 INFO - Running setup.py install for mozlog 01:34:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:34:39 INFO - Running setup.py install for moznetwork 01:34:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:34:39 INFO - Running setup.py install for mozprocess 01:34:39 INFO - Running setup.py install for mozprofile 01:34:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:34:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:34:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:34:39 INFO - Running setup.py install for mozrunner 01:34:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:34:39 INFO - Running setup.py install for mozscreenshot 01:34:39 INFO - Running setup.py install for moztest 01:34:40 INFO - Running setup.py install for mozversion 01:34:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:34:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:34:40 INFO - Cleaning up... 01:34:40 INFO - Return code: 0 01:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:40 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')]} 01:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:41 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')]} 01:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:41 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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:41 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 01:34:41 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 01:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:41 INFO - 'HOME': '/Users/cltbld', 01:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:41 INFO - 'LOGNAME': 'cltbld', 01:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:41 INFO - 'MOZ_NO_REMOTE': '1', 01:34:41 INFO - 'NO_EM_RESTART': '1', 01:34:41 INFO - 'PAGER': '/bin/cat', 01:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:41 INFO - 'PWD': '/builds/slave/test', 01:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:41 INFO - 'SHELL': '/bin/bash', 01:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:41 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:41 INFO - 'USER': 'cltbld', 01:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:41 INFO - 'XPC_FLAGS': '0x0', 01:34:41 INFO - 'XPC_SERVICE_NAME': '0', 01:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:41 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-okIinO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:41 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)) 01:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:41 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-zbSPL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:41 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)) 01:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:41 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-BWWcxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-ytKH4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-l95xpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-8pHx3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-kluAkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-rNuSW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Kd__km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-nsEoSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-ztEshX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:42 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)) 01:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:42 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-RYuTXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:43 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)) 01:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:43 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-aDrC70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:43 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)) 01:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:43 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-CPtrLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:43 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)) 01:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:43 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-3ILSLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:43 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)) 01:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:43 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-AS93bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:43 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)) 01:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:43 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-6aMn_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:43 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)) 01:34:43 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)) 01:34:43 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)) 01:34:43 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)) 01:34:43 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)) 01:34:43 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)) 01:34:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:46 INFO - Downloading blessings-1.6.tar.gz 01:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:34:46 INFO - Installing collected packages: blessings 01:34:46 INFO - Running setup.py install for blessings 01:34:46 INFO - Successfully installed blessings 01:34:46 INFO - Cleaning up... 01:34:46 INFO - Return code: 0 01:34:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:47 INFO - Reading from file tmpfile_stdout 01:34:47 INFO - Current package versions: 01:34:47 INFO - blessings == 1.6 01:34:47 INFO - blobuploader == 1.2.4 01:34:47 INFO - docopt == 0.6.1 01:34:47 INFO - functools32 == 3.2.3-2 01:34:47 INFO - jsonschema == 2.5.1 01:34:47 INFO - manifestparser == 1.1 01:34:47 INFO - mozInstall == 1.12 01:34:47 INFO - mozcrash == 1.0 01:34:47 INFO - mozdebug == 0.1 01:34:47 INFO - mozdevice == 0.49 01:34:47 INFO - mozfile == 1.2 01:34:47 INFO - mozhttpd == 0.7 01:34:47 INFO - mozinfo == 0.9 01:34:47 INFO - mozleak == 0.1 01:34:47 INFO - mozlog == 3.4 01:34:47 INFO - moznetwork == 0.27 01:34:47 INFO - mozprocess == 0.24 01:34:47 INFO - mozprofile == 0.28 01:34:47 INFO - mozrunner == 6.13 01:34:47 INFO - mozscreenshot == 0.1 01:34:47 INFO - mozsystemmonitor == 0.3 01:34:47 INFO - moztest == 0.8 01:34:47 INFO - mozversion == 1.4 01:34:47 INFO - psutil == 3.1.1 01:34:47 INFO - requests == 1.2.3 01:34:47 INFO - wsgiref == 0.1.2 01:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:47 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')]} 01:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:47 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')]} 01:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:47 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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:47 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 01:34:47 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 01:34:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:47 INFO - 'HOME': '/Users/cltbld', 01:34:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:47 INFO - 'LOGNAME': 'cltbld', 01:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:47 INFO - 'MOZ_NO_REMOTE': '1', 01:34:47 INFO - 'NO_EM_RESTART': '1', 01:34:47 INFO - 'PAGER': '/bin/cat', 01:34:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:47 INFO - 'PWD': '/builds/slave/test', 01:34:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:47 INFO - 'SHELL': '/bin/bash', 01:34:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:47 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:47 INFO - 'USER': 'cltbld', 01:34:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:47 INFO - 'XPC_FLAGS': '0x0', 01:34:47 INFO - 'XPC_SERVICE_NAME': '0', 01:34:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 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)) 01:34:47 INFO - Cleaning up... 01:34:47 INFO - Return code: 0 01:34:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:34:47 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')]} 01:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:47 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')]} 01:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:47 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 0x100fb1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9488610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, '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.iMVgPLbpNT/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.zpujSqvYKE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 01:34:47 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 01:34:47 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 01:34:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:34:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:47 INFO - 'HOME': '/Users/cltbld', 01:34:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:47 INFO - 'LOGNAME': 'cltbld', 01:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:47 INFO - 'MOZ_NO_REMOTE': '1', 01:34:47 INFO - 'NO_EM_RESTART': '1', 01:34:47 INFO - 'PAGER': '/bin/cat', 01:34:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:47 INFO - 'PWD': '/builds/slave/test', 01:34:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:47 INFO - 'SHELL': '/bin/bash', 01:34:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:34:47 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:34:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:47 INFO - 'USER': 'cltbld', 01:34:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:47 INFO - 'XPC_FLAGS': '0x0', 01:34:47 INFO - 'XPC_SERVICE_NAME': '0', 01:34:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:34:47 INFO - Cleaning up... 01:34:47 INFO - Return code: 0 01:34:47 INFO - Running post-action listener: _resource_record_post_action 01:34:47 INFO - Running post-action listener: _start_resource_monitoring 01:34:47 INFO - Starting resource monitoring. 01:34:47 INFO - [mozharness: 2017-02-09 09:34:47.844024Z] Finished create-virtualenv step (success) 01:34:47 INFO - [mozharness: 2017-02-09 09:34:47.845066Z] Running install step. 01:34:47 INFO - Running pre-action listener: _resource_record_pre_action 01:34:47 INFO - Running main action method: install 01:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:48 INFO - Reading from file tmpfile_stdout 01:34:48 INFO - Detecting whether we're running mozinstall >=1.0... 01:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:34:48 INFO - Reading from file tmpfile_stdout 01:34:48 INFO - Output received: 01:34:48 INFO - Usage: mozinstall [options] installer 01:34:48 INFO - Options: 01:34:48 INFO - -h, --help show this help message and exit 01:34:48 INFO - -d DEST, --destination=DEST 01:34:48 INFO - Directory to install application into. [default: 01:34:48 INFO - "/builds/slave/test"] 01:34:48 INFO - --app=APP Application being installed. [default: firefox] 01:34:48 INFO - mkdir: /builds/slave/test/build/application 01:34:48 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'] 01:34:48 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 01:35:08 INFO - Reading from file tmpfile_stdout 01:35:08 INFO - Output received: 01:35:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:35:08 INFO - Running post-action listener: _resource_record_post_action 01:35:08 INFO - [mozharness: 2017-02-09 09:35:08.379040Z] Finished install step (success) 01:35:08 INFO - [mozharness: 2017-02-09 09:35:08.379150Z] Running run-tests step. 01:35:08 INFO - Running pre-action listener: _resource_record_pre_action 01:35:08 INFO - Running main action method: run_tests 01:35:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:35:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:35:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:35:08 INFO - 2017-02-09 01:35:08.392 screenresolution[1625:7313] starting screenresolution argv=screenresolution get 01:35:08 INFO - 2017-02-09 01:35:08.395 screenresolution[1625:7313] Display 0: 1600x1200x32@60 01:35:08 INFO - 2017-02-09 01:35:08.400 screenresolution[1626:7316] starting screenresolution argv=screenresolution list 01:35:08 INFO - Available Modes on Display 0 01:35:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:35:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:35:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:35:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:35:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:35:08 INFO - Intel Iris: 01:35:08 INFO - Chipset Model: Intel Iris 01:35:08 INFO - Type: GPU 01:35:08 INFO - Bus: Built-In 01:35:08 INFO - VRAM (Dynamic, Max): 1536 MB 01:35:08 INFO - Vendor: Intel (0x8086) 01:35:08 INFO - Device ID: 0x0a2e 01:35:08 INFO - Revision ID: 0x0009 01:35:08 INFO - Displays: 01:35:08 INFO - Display: 01:35:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:35:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:35:08 INFO - Display Serial Number: 1600x1200 60 01:35:08 INFO - Main Display: Yes 01:35:08 INFO - Mirror: Off 01:35:08 INFO - Online: Yes 01:35:08 INFO - Rotation: Supported 01:35:08 INFO - Return code: 0 01:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:08 INFO - Python 2.7.3 01:35:08 INFO - Return code: 0 01:35:08 INFO - grabbing minidump binary from tooltool 01:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:08 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 0x100d8fd30>, '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 0x100cb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d84be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:08 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 01:35:08 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 01:35:08 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 01:35:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:08 INFO - Return code: 0 01:35:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:35:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:35:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:08 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/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 01:35:08 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/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0341 --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 01:35:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMVgPLbpNT/Render', 01:35:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:08 INFO - 'HOME': '/Users/cltbld', 01:35:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:08 INFO - 'LOGNAME': 'cltbld', 01:35:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:08 INFO - 'MOZ_NO_REMOTE': '1', 01:35:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:08 INFO - 'NO_EM_RESTART': '1', 01:35:08 INFO - 'PAGER': '/bin/cat', 01:35:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:08 INFO - 'PWD': '/builds/slave/test', 01:35:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:08 INFO - 'SHELL': '/bin/bash', 01:35:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zpujSqvYKE/Listeners', 01:35:08 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 01:35:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:08 INFO - 'USER': 'cltbld', 01:35:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:08 INFO - 'XPC_FLAGS': '0x0', 01:35:08 INFO - 'XPC_SERVICE_NAME': '0', 01:35:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:08 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/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 01:35:08 INFO - mozversion application_buildid: 20170209004121 01:35:08 INFO - mozversion application_changeset: eae7e45deb55defb86c7c30fdfcf20c5d017b98d 01:35:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:35:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:08 INFO - mozversion application_name: Firefox 01:35:08 INFO - mozversion application_remotingname: firefox-dev 01:35:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:08 INFO - mozversion application_vendor: Mozilla 01:35:08 INFO - mozversion application_version: 53.0a2 01:35:08 INFO - mozversion platform_buildid: 20170209004121 01:35:08 INFO - mozversion platform_changeset: eae7e45deb55defb86c7c30fdfcf20c5d017b98d 01:35:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:08 INFO - mozversion platform_version: 53.0a2 01:35:08 INFO - using testdate: 1486632908 01:35:08 INFO - actual date: 1486632908 01:35:08 INFO - starting webserver on 'localhost:49246' 01:35:08 INFO - SUITE-START | Running 2 tests 01:35:08 INFO - TEST-START | dromaeo_css 01:35:08 INFO - operating with platform_type : mac_ 01:35:08 INFO - Initialising browser for dromaeo_css test... 01:35:09 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp0VBmEL/profile http://localhost:49246/getInfo.html) 01:35:11 INFO - PROCESS | 1636 | 2017-02-09 01:35:11.902 plugin-container[1638:7490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 01:35:11 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:35:11 INFO - PROCESS | 1636 | 2017-02-09 01:35:11.905 plugin-container[1638:7490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 01:35:11 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:35:11 INFO - PROCESS | 1636 | 2017-02-09 01:35:11.905 plugin-container[1638:7490] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:35:11 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 01:35:11 INFO - PROCESS | 1636 | colorDepth:24 01:35:11 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 01:35:11 INFO - PROCESS | 1636 | __metrics 01:35:12 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:35:12 INFO - PROCESS | 1636 | 1486632912116 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/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp0VBmEL/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp0VBmEL/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp0VBmEL/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp0VBmEL/profile/extensions/talos-powers@TalosPowersService.js:55:9 01:35:12 INFO - TEST-INFO | 1636: exit 0 01:35:12 INFO - Browser initialized. 01:35:12 INFO - Running cycle 1/1 for dromaeo_css test... 01:35:12 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp0VBmEL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:15 INFO - PROCESS | 1639 | 2017-02-09 01:35:15.617 plugin-container[1640:7627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 01:35:15 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:35:15 INFO - PROCESS | 1639 | 2017-02-09 01:35:15.618 plugin-container[1640:7627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.CFPasteboardClient' 01:35:15 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:35:15 INFO - PROCESS | 1639 | 2017-02-09 01:35:15.618 plugin-container[1640:7627] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:35:25 INFO - PROCESS | 1639 | RSS: Main: 218464256 01:35:25 INFO - PROCESS | 1639 | 01:38:27 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 01:38:29 INFO - PROCESS | 1639 | RSS: Main: 235462656 01:38:29 INFO - PROCESS | 1639 | 01:40:13 INFO - PROCESS | 1639 | ************************* 01:40:13 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 01:40:13 INFO - PROCESS | 1639 | 01:40:13 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:13 INFO - PROCESS | 1639 | Full stack: 01:40:13 INFO - PROCESS | 1639 | ************************* 01:41:31 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 01:41:32 INFO - PROCESS | 1639 | RSS: Main: 245301248 01:41:32 INFO - PROCESS | 1639 | 01:44:34 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 01:44:34 INFO - PROCESS | 1639 | RSS: Main: 252260352 01:44:34 INFO - PROCESS | 1639 | 01:47:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 01:47:37 INFO - PROCESS | 1639 | RSS: Main: 248602624 01:47:37 INFO - PROCESS | 1639 | 01:50:40 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 01:50:40 INFO - PROCESS | 1639 | RSS: Main: 254013440 01:50:40 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 01:53:43 INFO - PROCESS | 1639 | RSS: Main: 255787008 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | __start_tp_report 01:53:43 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 01:53:43 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 01:53:43 INFO - PROCESS | 1639 | |i|pagename|runs| 01:53:43 INFO - PROCESS | 1639 | |0;dojo.html;3274.165087902585;3274.7216486598622;3314.303996160806;3317.1872891141675;3321.883734069307;5492.176173573966;5542.861428464285;5596.972015139923;5606.943930560693;5623.831285061445;5555.3611334696525;5618.213450116987;5641.661500309984;5692.117721753135;5694.402087780785;4850.733209673466;5126.641135120543;5161.9483805162035;5191.662541934762;5215.21771734241;5204.089284375238;5215.687058776485;5224.791008359661;5227.32044834171;5230.973845130769;5060.645754797166;5089.949100508985;5205.713685747282;5214.817481388152;5265.921011184835;5152.021115987969;5178.119719647669;5191.039657663326;5211.661242019257;5266.289050978107;5023.89254810795;5152.92270615941;5154.974225128851;5175;5240.423553409122;5434.994526012701;5597.3003374578175;5619.325680918275;5740.942590574083;5742.339630942453;6035.668038257894;6124.203853499017;6139.829471381233;6143.4470897618985;6193.659348735818;5607.551395888319;5879.235699359056;6248.9062664060075;6261.342559031282;6265.279492858334;5745.540356771448;5763.135529670583;5765.164051212592;5772.2496075510335;5780.653160810365;6140.631562106288;6183.072539119168;6192.318844927055;6208.379162083846;6216.906746398808;6008.819735407945;6074.757009719562;6089.939100608937;6103.664298463627;6115.118650813375;6131.172291740647;6197.03945888388;6215.906761398583;6219.968900155471;6246.187995560548;5961.761529538857;6011.969940150271;6116.816495505142;6121.788327166048;6142.1893435155225;6187.257529096447;6215.160953271251;6227.532935029801;6229.314775374705;6246.562740608114;4955.826546070943;4960.330355402047;4972.701637901738;4983.5763960063805;4994.051130285234;4302;4337.9783101084295;4357.673174511924;4416.24923762961;4442.555744425532;5657.462541058593;5705.62913410627;5775.797847075332;5791.594588378857;5815.331236907809;5191.831837836532;6176.66028368435;6205.503559715302;6218.844528886814;6220.782272620437;5539.695316757617;5578.191162281528;5580.972095139498;5588.413216612278;5619.8595035123635;5369.060414427459;5381.811636592701;5385.892282154335;5398.6220964532895;5418.891622167614;6201.317855035943;6215.595986260879;6219.502439804895;6224.253089629274;6230.906536402048;6108.11432342299;6141.946315431794;6172.629642221302;6185.134081228722;6210.5652604317265;6201.255849298113;6263.09185168139;6265.74937002533;6267.2479302484;6283.37166283368;5179.559737422362;5806.535477161732;6188.783392581238;6191.876162476815;6213.1922850029205;5865.589408741347;6098.817035488943;6127.234095738033;6199.783007594712;6200.875982480416;4537.296719008559;6014.158017877413;6051.9711649020655;6064.272287325549;6079.118527813531;5959.67221802805;6011.489023432882;6033.879322413615;6035.728392222272;6043.425874541911;5002.774875130555;5560.527355174693;5732.484076433141;5776.884462310814;5898.056310990392;5978.491828194652;5993.730282137227;6013.819585412444;6115.635867915819;6136.7948077883175;5894.587378883437;5931.228940237914;5938.346781853907;5955.880882382241;5973.49225315853 01:53:43 INFO - PROCESS | 1639 | |1;ext.html;459.28581056457205;496.7119070938854;503.11451844753225;509.9541041306282;529.753664545986;38230.61769382306;41510.377344339824;41521.16957660849;41660.37509437361;41675;41481.377779333336;41682.74951751445;42140.57859421405;42215.577844221545;42223.788881055625;6622.37087476689;8694.782630434227;9078.727638170865;9346.532673366339;9348.813023739522;11109.277896936714;11387.658370248906;11419.828702569468;11539.076873850072;11550.249233799817;11328.943355283212;11377.601783937564;11463;11470.25443346184;11474.770504589904;11318.377489238088;11350.772984540345;11414.885851141507;11426.542938282459;11450.484728187252;11317.660470185907;11357.204995650307;11381.260218085881;11432.485538150802;11435.42822858862;40745;40960;40989;41240.76277711673;41248.587514124774;3896.279188350164;3897.2595206910596;3933.2920074386598;3975.4434379186937;3980.681545476355;27082.864585677144;27110.1866943992;27189.728102719117;27221.047263345885;28293.434131317463;2774.6531683539556;2988.9701102989125;3150.6534281229046;3231.6122065352074;3258.462353711635;480439.5978020122;480669;483690.5815470935;485171;485617.5719121417;56631.150532742045;56973.86052278931;56976.14535781967;57031.71484142553;57088;56371.15443268272;56561;56582;57109.714451428306;57227;15790.447334343244;15987.44043958479;16033.518994429953;16093.678126437406;16124.03255804632;11189.608363707232;11388.544458221579;12144.635660930186;12329.568465103679;12360.938195308965;17936.55158621019;18088.819111808978;18115.003674798012;18122.45632630997;18156;7296.927030729731;7540.585267810323;7645.847083058307;7701.730439434593;7754.418418618626;750.264740554249;870.6691457246205;904.9230815380635;911.6581282019242;914.7667344827026;29573.704262957526;30080.699193008226;30512.694873050987;31016.844915775728;31135.065948021143;1028.9125424339015;1066.7173199102244;1087.6030248959073;1102.443266150589;1148.2019996102629;12634.747305053848;15796.92101539485;15804.288807003712;15901.602459938595;16103;598777;599264;600590;600617;601422;60266;60555.69722151449;60737.392626073175;60831.69584152051;60854.69572652109;1400;1424.985750142506;1447.7466443372368;1452.208546342246;1455.0105927969082;25805.870970645028;29165.56251656269;29702.108936731933;29895;30599.2350191247;50814.74592627161;51282.74358628183;51284.48715512797;51324;51484.712882178246;521399;522343;524175;526974;528196;26110.73889261159;26578.601320980586;26875.193744187705;27004;27049.59425608578;38965.80517097397;43035.569644303156;47048;48163.31428399989;48569.51430485791;38523.80738096291;38961.220775583766;39387;40546.783596492154;40753.1849363017;39033.41449878311;39783;39827;40061.28111463751;40552.797236013634;37040;37583;37681.86954391373;38049.2390152201;38153.42769858399;32817.50773738443;34042.97871063872;34635.13412164716;34683.30633387368;34820.26549992563;25142.62286065674;25243.799947286556;25267.241982740547;25355.61966570466;25787.355316117246 01:53:43 INFO - PROCESS | 1639 | |2;jquery.html;334.17292201800547;353.9539859818223;382.62120500704305;388.6793395448756;405.161316075723;19039.52401189969;19938.202471901106;19988.000599969997;20378.184872605096;20620.48448788781;20435.38693839187;20542.794572054274;21115.838628875405;21169.788302116973;21534.676979845313;5006.399232092154;5404.405515393303;5653.1237658162945;5828.533717302626;5864.530837532987;4922.286268491067;5779.07534794433;5853.356130825606;5855.8536036599;5865.178874957509;5668.57485688573;5776.335721392031;5789.45000224978;5924.555658325643;6021.096835474692;5161.303224064741;5950.494207992326;5978.133170690247;5982.581219314649;6013.819585412422;5718.285214348207;5919.970400148015;5943.821685349447;5944.316403613553;5949.6430214187285;13620.59138225845;13703.794443083361;19360;25523.85142668566;25841.870790646113;2533.8606376649277;2549.821512494126;2598.3763896664855;2629.6449979252748;2642.748938850806;9660.130588247092;10170.796584068352;10223.744406389826;10530.473476326153;10593.205509586813;1747.3010795681703;1839.9632007359778;1864.459306801026;1867.5517875709868;1874.8406385457251;109567.45216273947;135314.32342838222;136269.3186534061;136390;139323.30338348344;12123.75752484963;12144.817827732591;12179.817302740466;12321.260724356567;12438.81341779874;15868.761968570481;16019.519414417586;16038.599035024217;16057.598560036093;16089.919550402406;8769.91230087691;8971.551422428853;9011.909880901107;9099.363044586815;9119.635214591475;8656.956715216384;8671.4363566368;8674.6530138795;8775.605097770487;8825.823483530294;4835.347228124158;4884.340614017134;4898.118338698997;4932.284818701268;4949.876253093629;2022.6662600671018;2086.35323049855;2100.0864623888656;2103.169248147004;2105.126372555403;996.3473924579412;1006.411249419098;1019.1591936652144;1021.3565453764081;1033.2715435617872;18670.34653787138;21085.57828843445;21407.357779266647;21550.245741398976;21568.4607884801;918.4213945214472;1022.2537547590152;1031.654395777408;1066.642674703983;1068.6641697877653;10795.352278863293;11127.554897804159;11146.439498470221;11171.720706982227;11234.662960111209;750900;764150;769967;771056;773880;130195;133235;153360;155267.22366388096;166889;741.8775901976113;956.4739393333778;1027.9691609251586;1032.7418145463635;1043.3166276089173;15848.60378490547;19580;20214.898925505277;20238.291659791837;20328.491787705425;49958;59506.404935950086;60433.69783151232;60966;61435.69282153561;86911;91537;91828.54085729529;91832.62251066105;92137.53931230301;6406.84676758188;8280.130586288353;8381.11998240176;8484.872726908978;8635.611397487253;10773.946130269298;11302.321860688386;12350.75298494043;12675.873241267838;12804.679883003;10776.568937242737;10852.457377130953;10956.123510119012;10966.945165274123;11454.255473394203;10335.793284134426;10850.348979061282;10901.691796984413;11221;11310.60412885545;11149.442527873736;11230.719232019264;11278.661640150809;11403.885961140282;11580.247283926517;8389.622466989122;8504.53225072627;8568.228859402683;8685.348598854986;8688.174623410765;7057.611831349325;7474.617195818791;7848.646810893638;8078.9192108080515;10760 01:53:43 INFO - PROCESS | 1639 | |3;mootools.html;1406.6413064668513;1419.4606049701113;1421.452740694832;1428.3572392423405;1440.042371822738;7427.071616047994;7692.538447693142;7968.4023698222645;8404.789880252989;8417.957910210447;7957.880631790514;8234.547099909518;8252.504849709021;8326.167383261685;8344.3741719371;2074.543600407908;2103.5161912760072;2105.1895020417173;2105.620988222119;2112.5458026524293;1861.5997560524484;1938.4572319750423;2050.63088644044;2079.542500649862;2085.582883423314;1768.9823101769011;2024.87850728956;2096.224396973122;2098.12927635032;2103.295396042328;2104.084723145437;2111.092230340953;2126.904289306985;2131.1581925139562;2136.861104028241;2105.768365479796;2148.215901196052;2162.351294611626;2170.4899348653053;2185.9890700546553;8241.175882411711;8421.368397370221;8444.619992100308;8463.984321881351;8478.194571515696;4984.451710311862;5116.283720279164;5128.9230661540105;5132.358455193101;5145.768440420153;2845.2460098074025;2896.652401711808;3349.1961929137074;3380.8478618462227;3384.170878134848;1159.4695002596575;1197.7903866823358;1200.4717924113363;1225.8528976522875;1674.4306935641819;10611.78776424475;10738.731531711692;10843;10876.836847447295;10951.178661600332;4238.915221695611;4400.73595584266;4444;4454.844080457168;4466.865994020184;7434.628268586549;8475.618597163018;8706.782330441789;8710.69512567057;8715.782105447415;5065.898682026339;5079.74601269935;5081.18701007837;5083.059633967728;5084.745762711849;4031.9920019995;4557.065801510682;4684.391029166255;4710.9764451177525;4721.834735784231;3547.1309529165005;3563.2873425314524;3583.9104022399647;3608.693261072838;3618.5295911531334;1059.5761695321778;1075.542894269932;1138.612871623652;1138.8120960041665;1139.4132022008673;746.216472703659;765.9080910290689;781.2773184804147;799.5322736199389;818.8771684247291;5368.221607866837;5434.10337294342;5483.8080667176455;5588.720563971785;5698.031334673115;782.8473447677649;930.0192881813771;973.6105557776805;994.6021591363512;997.755549890267;3515.226650136966;3562.4656301554974;3576.2668652926086;3677.9264414711556;3695.796731179811;9365.953170234105;9958.402495850272;10144.391336519833;10155.136813370798;10156.644517441853;9965.302428829913;9998.25013124004;10000.549975250986;10032.749181270381;10062.949685251528;7757.26306000929;7800.648970796327;7824.960875195701;7900.525968441912;7918.604069796487;5300.469953004668;5371.758270877898;5436.483534064258;5458.890822183614;5513.035218836768;9086.772830679285;9105.408148470593;9184.908150918405;9307.06929307064;9322.207612352755;8907.599158037774;9255.167034966616;9266.490343031199;9337;9388.57751401175;5858.765649374148;7158.534695244793;7187.281271872771;7189.676464559003;7189.784306470814;7707.961460192663;7744.65149068282;7787.727429539939;7788.1433042366425;7827.882581761164;6857.177138743383;6902.758403455855;6927.3419025192525;6984.895226571707;7014.158301003912;6627.237867645283;6664;6735.898961515483;6752.662366881538;6786.728530858711;6160.845978850564;6280.685965701605;6366.77716279928;6403.327650596807;6406.519511036784;4871.853844384674;4876.4392094909535;4885.267209918541;4916.139675556835;4929.13740095489;4835.734034628129;4891.33966914462;4892.363992680928;4966.329545511309;4977.377827771528 01:53:43 INFO - PROCESS | 1639 | |4;prototype.html;318.2918007433461;357.33000623830316;364.2969069695487;369.43476480984094;373.701039168665;4672.859814205571;5079.56823669988;5306.469353064692;5331.333583302087;5375.731213439332;4900.828471003516;5065.4934506549325;5082.440931497532;5175.948240517594;5209.921851172226;3662.505561749156;4105.404716316132;4110.438033547248;4143.81352839123;4157.189348077111;3612.6929211017095;3954.1696243788697;3995.981024838662;4039.4950631171105;4159.3968874513175;3126.124685088179;4022.034711669208;4049.623128136433;4084.1627466369323;4137.524184718765;4085.8774236772942;4090.5295890972475;4097.242010228118;4104.91790164198;4106.1992911382295;3031.4998025325795;3110.7666924980717;3639.5814481334455;3657.3359121599874;3683.189698266404;4868.610511159099;4991.32617096691;5105.438401775802;5154.587632989352;5161.948380516222;3901.5708272090046;4555.681102322838;4581.885452863672;4602.815887364502;4650.419017445316;5257.605679574047;5342.4089316681375;5629.324481062258;5640.689762063085;5676;3266.7386609071455;3440.8451619677176;3723.94414083789;3856.2094770571966;3860.7104467164795;5556.611037227396;5868.219803493555;5887.586089703201;5926.229590153295;5935.37678543751;3847.34564137418;3890.2414029264023;3902.824372903169;3912.882613521599;3942.9605703942593;3959.8614048508166;3967.8412863485137;3970.563238043813;3974.642282194616;3984.820683069269;3604.8377822998027;4247.17180149874;4529.796159172845;4578.24583841247;4614.238650622677;4545.159145558082;5241.528262456321;5417.864553386197;5671.143622336768;5744.195812586241;1108.3017698849835;1126.594426006637;1277.086882878746;1290.7547565962436;1294.2752058846888;736.9042024536776;794.9920500795033;819.0089991110823;859.5873980489275;864.0150228739242;4955.82654607087;4970.247463165287;5009.398872135367;5009.774560144802;5025.763535226862;4639.907201855944;4831.685940413862;5065.594752419797;5546.972265138648;5575.944240557624;4685.437747470257;4988.054658683044;4991.625628077909;5016.423111342169;5023.447420783711;2471.690004297689;2654.9911033807416;2729.7543221110195;2890.6097676813783;2908.8109272897195;5082.771275292546;5540.307461567304;5749.511291540266;5756.366799652035;5757.712114394263;5477.452254774491;5986.49114825236;5986.880262394728;5987.856375402948;6035.66803825785;5989.850253743692;5994.520438364921;6008.549358798107;6056.273247210363;6103.267607887082;5183.844484665466;5517.834464966058;5576.5817563683695;5820.417958204315;5841.342189303771;4920.852374428773;5775.393583673654;5793.536517078539;5798.246227990334;5826.73779679907;5178.741062946762;5809.796657116981;6029.909551356645;6058.909116363347;6065.6049108704365;3296.8351582420305;3677.8528858845348;3910.4720862683175;3925.4700615416555;3952.26883026641;4943.678660887031;5087.440381557952;5787.247657804459;5813.360530341574;5860.8571328590515;5400.918986215289;5606.943930560642;5640.266765320482;5643.463870932255;5707.800226992035;4757.904841903073;5407.107827208624;5572.777088916398;5592.2170896075395;5594.5384031026215;4879.634027448026;5071.797128114834;5219.739013049409;5344.679319240858;5525.712201240256;5416.620836541404;5440.6735595864375;5449.754761035842;5612.635178713371;5666.631668941505;4577.793999269974;5373.274607928036;5518.847649416651;5569.749361278833;5639.379668236573 01:53:43 INFO - PROCESS | 1639 | |5;yui.html;698.1273408239697;698.4656737595737;765.2271206081859;815.213319147023;830.5971603772167;14245.572632821006;15365.769513457279;15383.846161538382;15455.459058932925;15461.30424130914;13512.662183445418;13599.18404895707;13620.318984050782;13628.591142265723;13630.386632601532;833.3624777045565;848.2832006954114;857.8670306102564;861.2894362151219;865.7402779166256;851.9488830670149;862.8188080503071;863.2834747159842;864.9922839891519;869.7043005378171;802.7029998900415;860.9440386374897;892.1747383670112;893.2630579771715;898.0570401078874;890.0787684746257;890.6570970176497;891.790429249126;895.0870112485294;896.3232759266745;655.0632595388593;665.2383021440472;667.0860920538844;667.6961982298043;667.9913330870372;13956.302184890816;14204.71590568183;15261.160636165007;15348.462803801925;15499.845001549953;11666.591669291534;12682.619521414372;13638.249896255702;13897.235652039133;13906.096103753223;10311.43287119208;11972.521099156023;12317.876821231763;12358.938205308916;12675.239485630891;3775;4405.911881762347;4417.660706567366;4453.131639330332;4610.400647915783;80855.26906836755;81194;82008.58995705043;100143.49928250312;103462.48268758607;10353.689389318333;10442.738931526621;10456.68629941103;10713.678589642323;10940.890591094147;20744;20871.060802263935;21548.676769848465;21577.352679419644;21617.702937823782;7474.065741782278;7497.88753168692;7547.396208303323;7553.169151393342;7652.69389224436;4188.099558594856;4243.427137336482;4249.383839343278;4256.127493863813;4273.9358909616385;3450.741194410429;3477;3494.598121216042;3534.2401383702627;3537.133402316449;650.0541711809307;651.0852252585125;657.2999755260632;658.8568833074612;664.1697877652933;576.3775122867294;584.4249746931978;605.12257227021;612.3998481488167;621.471749013335;9801.754956126153;10150.441725705157;10325.896741032493;10398.636047738293;10526.684199474028;682.617734068923;682.6825526130373;690.944724422045;695.1033167214237;701.5194591704699;4772.546608072227;4942.678725882806;4954.1082605130705;4970.179920313108;4988.176950803149;103694;104723;104800.47599761952;105392.47303763432;106497.93502065036;62867.685661572315;71025.22436939117;75546.62226688831;75974;79557;64190.35809641844;72562;73642.6317868418;76336.61831690806;77746.6112669433;8647.947085985274;10221.23340749432;11015.779684406107;11180.888191117985;11228.270162439416;46039;49690.751546242034;49926;50368.74815626045;52089.739551302;60604;69626.95559566712;70138;70666.6466667684;71778;12639.304838233986;13150.60548183556;13292.933535332262;13361.799573006218;13417.597472075462;13684.452621895012;14086.084404514084;14361.64095897611;14934;14935.775963360342;12834.358282085672;13539.052266341261;13540.526081587097;13704.2069168023;13717.314134293047;13159.934200328937;13540.79688804649;13619.918284471734;13627.250501222528;14192.92903535517;12794;12940.870591294342;13252;13441.260730659907;13899;10501.616591358597;11190.657121145514;11389.829152562885;11408.771824563297;11621.709457263636;8546.529940853312;9403.482808445327;9805.983177273414;10549.630762923261;10967.287126336763 01:53:43 INFO - PROCESS | 1639 | __end_tp_report 01:53:43 INFO - PROCESS | 1639 | __start_cc_report 01:53:43 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,376 01:53:43 INFO - PROCESS | 1639 | __end_cc_report 01:53:43 INFO - PROCESS | 1639 | __startTimestamp1486634023853__endTimestamp 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | ------- Summary: start ------- 01:53:43 INFO - PROCESS | 1639 | Number of tests: 6 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5659.42 Median:5806.54 stddev:635.29 (10.9%) stddev-sans-first:609.06 01:53:43 INFO - PROCESS | 1639 | Values: 3274.2 3274.7 3314.3 3317.2 3321.9 5492.2 5542.9 5597.0 5606.9 5623.8 5555.4 5618.2 5641.7 5692.1 5694.4 4850.7 5126.6 5161.9 5191.7 5215.2 5204.1 5215.7 5224.8 5227.3 5231.0 5060.6 5089.9 5205.7 5214.8 5265.9 5152.0 5178.1 5191.0 5211.7 5266.3 5023.9 5152.9 5155.0 5175.0 5240.4 5435.0 5597.3 5619.3 5740.9 5742.3 6035.7 6124.2 6139.8 6143.4 6193.7 5607.6 5879.2 6248.9 6261.3 6265.3 5745.5 5763.1 5765.2 5772.2 5780.7 6140.6 6183.1 6192.3 6208.4 6216.9 6008.8 6074.8 6089.9 6103.7 6115.1 6131.2 6197.0 6215.9 6220.0 6246.2 5961.8 6012.0 6116.8 6121.8 6142.2 6187.3 6215.2 6227.5 6229.3 6246.6 4955.8 4960.3 4972.7 4983.6 4994.1 4302.0 4338.0 4357.7 4416.2 4442.6 5657.5 5705.6 5775.8 5791.6 5815.3 5191.8 6176.7 6205.5 6218.8 6220.8 5539.7 5578.2 5581.0 5588.4 5619.9 5369.1 5381.8 5385.9 5398.6 5418.9 6201.3 6215.6 6219.5 6224.3 6230.9 6108.1 6141.9 6172.6 6185.1 6210.6 6201.3 6263.1 6265.7 6267.2 6283.4 5179.6 5806.5 6188.8 6191.9 6213.2 5865.6 6098.8 6127.2 6199.8 6200.9 4537.3 6014.2 6052.0 6064.3 6079.1 5959.7 6011.5 6033.9 6035.7 6043.4 5002.8 5560.5 5732.5 5776.9 5898.1 5978.5 5993.7 6013.8 6115.6 6136.8 5894.6 5931.2 5938.3 5955.9 5973.5 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:67411.47 Median:38377.21 stddev:143423.82 (373.7%) stddev-sans-first:143738.07 01:53:43 INFO - PROCESS | 1639 | Values: 459.3 496.7 503.1 510.0 529.8 38230.6 41510.4 41521.2 41660.4 41675.0 41481.4 41682.7 42140.6 42215.6 42223.8 6622.4 8694.8 9078.7 9346.5 9348.8 11109.3 11387.7 11419.8 11539.1 11550.2 11328.9 11377.6 11463.0 11470.3 11474.8 11318.4 11350.8 11414.9 11426.5 11450.5 11317.7 11357.2 11381.3 11432.5 11435.4 40745.0 40960.0 40989.0 41240.8 41248.6 3896.3 3897.3 3933.3 3975.4 3980.7 27082.9 27110.2 27189.7 27221.0 28293.4 2774.7 2989.0 3150.7 3231.6 3258.5 480439.6 480669.0 483690.6 485171.0 485617.6 56631.2 56973.9 56976.1 57031.7 57088.0 56371.2 56561.0 56582.0 57109.7 57227.0 15790.4 15987.4 16033.5 16093.7 16124.0 11189.6 11388.5 12144.6 12329.6 12360.9 17936.6 18088.8 18115.0 18122.5 18156.0 7296.9 7540.6 7645.8 7701.7 7754.4 750.3 870.7 904.9 911.7 914.8 29573.7 30080.7 30512.7 31016.8 31135.1 1028.9 1066.7 1087.6 1102.4 1148.2 12634.7 15796.9 15804.3 15901.6 16103.0 598777.0 599264.0 600590.0 600617.0 601422.0 60266.0 60555.7 60737.4 60831.7 60854.7 1400.0 1425.0 1447.7 1452.2 1455.0 25805.9 29165.6 29702.1 29895.0 30599.2 50814.7 51282.7 51284.5 51324.0 51484.7 521399.0 522343.0 524175.0 526974.0 528196.0 26110.7 26578.6 26875.2 27004.0 27049.6 38965.8 43035.6 47048.0 48163.3 48569.5 38523.8 38961.2 39387.0 40546.8 40753.2 39033.4 39783.0 39827.0 40061.3 40552.8 37040.0 37583.0 37681.9 38049.2 38153.4 32817.5 34043.0 34635.1 34683.3 34820.3 25142.6 25243.8 25267.2 25355.6 25787.4 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:41001.34 Median:21471.02 stddev:127413.08 (593.4%) stddev-sans-first:127733.92 01:53:43 INFO - PROCESS | 1639 | Values: 334.2 354.0 382.6 388.7 405.2 19039.5 19938.2 19988.0 20378.2 20620.5 20435.4 20542.8 21115.8 21169.8 21534.7 5006.4 5404.4 5653.1 5828.5 5864.5 4922.3 5779.1 5853.4 5855.9 5865.2 5668.6 5776.3 5789.5 5924.6 6021.1 5161.3 5950.5 5978.1 5982.6 6013.8 5718.3 5920.0 5943.8 5944.3 5949.6 13620.6 13703.8 19360.0 25523.9 25841.9 2533.9 2549.8 2598.4 2629.6 2642.7 9660.1 10170.8 10223.7 10530.5 10593.2 1747.3 1840.0 1864.5 1867.6 1874.8 109567.5 135314.3 136269.3 136390.0 139323.3 12123.8 12144.8 12179.8 12321.3 12438.8 15868.8 16019.5 16038.6 16057.6 16089.9 8769.9 8971.6 9011.9 9099.4 9119.6 8657.0 8671.4 8674.7 8775.6 8825.8 4835.3 4884.3 4898.1 4932.3 4949.9 2022.7 2086.4 2100.1 2103.2 2105.1 996.3 1006.4 1019.2 1021.4 1033.3 18670.3 21085.6 21407.4 21550.2 21568.5 918.4 1022.3 1031.7 1066.6 1068.7 10795.4 11127.6 11146.4 11171.7 11234.7 750900.0 764150.0 769967.0 771056.0 773880.0 130195.0 133235.0 153360.0 155267.2 166889.0 741.9 956.5 1028.0 1032.7 1043.3 15848.6 19580.0 20214.9 20238.3 20328.5 49958.0 59506.4 60433.7 60966.0 61435.7 86911.0 91537.0 91828.5 91832.6 92137.5 6406.8 8280.1 8381.1 8484.9 8635.6 10773.9 11302.3 12350.8 12675.9 12804.7 10776.6 10852.5 10956.1 10966.9 11454.3 10335.8 10850.3 10901.7 11221.0 11310.6 11149.4 11230.7 11278.7 11403.9 11580.2 8389.6 8504.5 8568.2 8685.3 8688.2 7057.6 7474.6 7848.6 8078.9 10760.0 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5302.66 Median:5083.90 stddev:2962.06 (58.3%) stddev-sans-first:2955.90 01:53:43 INFO - PROCESS | 1639 | Values: 1406.6 1419.5 1421.5 1428.4 1440.0 7427.1 7692.5 7968.4 8404.8 8418.0 7957.9 8234.5 8252.5 8326.2 8344.4 2074.5 2103.5 2105.2 2105.6 2112.5 1861.6 1938.5 2050.6 2079.5 2085.6 1769.0 2024.9 2096.2 2098.1 2103.3 2104.1 2111.1 2126.9 2131.2 2136.9 2105.8 2148.2 2162.4 2170.5 2186.0 8241.2 8421.4 8444.6 8464.0 8478.2 4984.5 5116.3 5128.9 5132.4 5145.8 2845.2 2896.7 3349.2 3380.8 3384.2 1159.5 1197.8 1200.5 1225.9 1674.4 10611.8 10738.7 10843.0 10876.8 10951.2 4238.9 4400.7 4444.0 4454.8 4466.9 7434.6 8475.6 8706.8 8710.7 8715.8 5065.9 5079.7 5081.2 5083.1 5084.7 4032.0 4557.1 4684.4 4711.0 4721.8 3547.1 3563.3 3583.9 3608.7 3618.5 1059.6 1075.5 1138.6 1138.8 1139.4 746.2 765.9 781.3 799.5 818.9 5368.2 5434.1 5483.8 5588.7 5698.0 782.8 930.0 973.6 994.6 997.8 3515.2 3562.5 3576.3 3677.9 3695.8 9366.0 9958.4 10144.4 10155.1 10156.6 9965.3 9998.3 10000.5 10032.7 10062.9 7757.3 7800.6 7825.0 7900.5 7918.6 5300.5 5371.8 5436.5 5458.9 5513.0 9086.8 9105.4 9184.9 9307.1 9322.2 8907.6 9255.2 9266.5 9337.0 9388.6 5858.8 7158.5 7187.3 7189.7 7189.8 7708.0 7744.7 7787.7 7788.1 7827.9 6857.2 6902.8 6927.3 6984.9 7014.2 6627.2 6664.0 6735.9 6752.7 6786.7 6160.8 6280.7 6366.8 6403.3 6406.5 4871.9 4876.4 4885.3 4916.1 4929.1 4835.7 4891.3 4892.4 4966.3 4977.4 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4518.35 Median:5024.61 stddev:1409.91 (28.1%) stddev-sans-first:1378.17 01:53:43 INFO - PROCESS | 1639 | Values: 318.3 357.3 364.3 369.4 373.7 4672.9 5079.6 5306.5 5331.3 5375.7 4900.8 5065.5 5082.4 5175.9 5209.9 3662.5 4105.4 4110.4 4143.8 4157.2 3612.7 3954.2 3996.0 4039.5 4159.4 3126.1 4022.0 4049.6 4084.2 4137.5 4085.9 4090.5 4097.2 4104.9 4106.2 3031.5 3110.8 3639.6 3657.3 3683.2 4868.6 4991.3 5105.4 5154.6 5161.9 3901.6 4555.7 4581.9 4602.8 4650.4 5257.6 5342.4 5629.3 5640.7 5676.0 3266.7 3440.8 3723.9 3856.2 3860.7 5556.6 5868.2 5887.6 5926.2 5935.4 3847.3 3890.2 3902.8 3912.9 3943.0 3959.9 3967.8 3970.6 3974.6 3984.8 3604.8 4247.2 4529.8 4578.2 4614.2 4545.2 5241.5 5417.9 5671.1 5744.2 1108.3 1126.6 1277.1 1290.8 1294.3 736.9 795.0 819.0 859.6 864.0 4955.8 4970.2 5009.4 5009.8 5025.8 4639.9 4831.7 5065.6 5547.0 5575.9 4685.4 4988.1 4991.6 5016.4 5023.4 2471.7 2655.0 2729.8 2890.6 2908.8 5082.8 5540.3 5749.5 5756.4 5757.7 5477.5 5986.5 5986.9 5987.9 6035.7 5989.9 5994.5 6008.5 6056.3 6103.3 5183.8 5517.8 5576.6 5820.4 5841.3 4920.9 5775.4 5793.5 5798.2 5826.7 5178.7 5809.8 6029.9 6058.9 6065.6 3296.8 3677.9 3910.5 3925.5 3952.3 4943.7 5087.4 5787.2 5813.4 5860.9 5400.9 5606.9 5640.3 5643.5 5707.8 4757.9 5407.1 5572.8 5592.2 5594.5 4879.6 5071.8 5219.7 5344.7 5525.7 5416.6 5440.7 5449.8 5612.6 5666.6 4577.8 5373.3 5518.8 5569.7 5639.4 01:53:43 INFO - PROCESS | 1639 | 01:53:43 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19453.00 Median:4252.76 stddev:27167.72 (638.8%) stddev-sans-first:27207.43 01:53:43 INFO - PROCESS | 1639 | Values: 698.1 698.5 765.2 815.2 830.6 14245.6 15365.8 15383.8 15455.5 15461.3 13512.7 13599.2 13620.3 13628.6 13630.4 833.4 848.3 857.9 861.3 865.7 851.9 862.8 863.3 865.0 869.7 802.7 860.9 892.2 893.3 898.1 890.1 890.7 891.8 895.1 896.3 655.1 665.2 667.1 667.7 668.0 13956.3 14204.7 15261.2 15348.5 15499.8 11666.6 12682.6 13638.2 13897.2 13906.1 10311.4 11972.5 12317.9 12358.9 12675.2 3775.0 4405.9 4417.7 4453.1 4610.4 80855.3 81194.0 82008.6 100143.5 103462.5 10353.7 10442.7 10456.7 10713.7 10940.9 20744.0 20871.1 21548.7 21577.4 21617.7 7474.1 7497.9 7547.4 7553.2 7652.7 4188.1 4243.4 4249.4 4256.1 4273.9 3450.7 3477.0 3494.6 3534.2 3537.1 650.1 651.1 657.3 658.9 664.2 576.4 584.4 605.1 612.4 621.5 9801.8 10150.4 10325.9 10398.6 10526.7 682.6 682.7 690.9 695.1 701.5 4772.5 4942.7 4954.1 4970.2 4988.2 103694.0 104723.0 104800.5 105392.5 106497.9 62867.7 71025.2 75546.6 75974.0 79557.0 64190.4 72562.0 73642.6 76336.6 77746.6 8647.9 10221.2 11015.8 11180.9 11228.3 46039.0 49690.8 49926.0 50368.7 52089.7 60604.0 69627.0 70138.0 70666.6 71778.0 12639.3 13150.6 13292.9 13361.8 13417.6 13684.5 14086.1 14361.6 14934.0 14935.8 12834.4 13539.1 13540.5 13704.2 13717.3 13159.9 13540.8 13619.9 13627.3 14192.9 12794.0 12940.9 13252.0 13441.3 13899.0 10501.6 11190.7 11389.8 11408.8 11621.7 8546.5 9403.5 9806.0 10549.6 10967.3 01:53:43 INFO - PROCESS | 1639 | -------- Summary: end -------- 01:53:43 INFO - PROCESS | 1639 | 01:53:44 INFO - TEST-INFO | 1639: exit 0 01:53:44 INFO - TEST-OK | dromaeo_css | took 1115483ms 01:53:44 INFO - TEST-START | kraken 01:53:44 INFO - operating with platform_type : mac_ 01:53:44 INFO - Initialising browser for kraken test... 01:53:44 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpixKs4b/profile http://localhost:49246/getInfo.html) 01:53:47 INFO - PROCESS | 1651 | 2017-02-09 01:53:47.258 plugin-container[1652:9892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 01:53:47 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:53:47 INFO - PROCESS | 1651 | 2017-02-09 01:53:47.262 plugin-container[1652:9892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 01:53:47 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:53:47 INFO - PROCESS | 1651 | 2017-02-09 01:53:47.262 plugin-container[1652:9892] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:53:47 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 01:53:47 INFO - PROCESS | 1651 | colorDepth:24 01:53:47 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 01:53:47 INFO - PROCESS | 1651 | __metrics 01:53:47 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:53:47 INFO - PROCESS | 1651 | 1486634027416 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/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpixKs4b/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpixKs4b/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpixKs4b/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpixKs4b/profile/extensions/talos-powers@TalosPowersService.js:55:9 01:53:48 INFO - TEST-INFO | 1651: exit 0 01:53:48 INFO - Browser initialized. 01:53:48 INFO - Running cycle 1/1 for kraken test... 01:53:48 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpixKs4b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:50 INFO - PROCESS | 1653 | 2017-02-09 01:53:50.571 plugin-container[1654:10020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 01:53:50 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:53:50 INFO - PROCESS | 1653 | 2017-02-09 01:53:50.572 plugin-container[1654:10020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8953, name = 'com.apple.CFPasteboardClient' 01:53:50 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:53:50 INFO - PROCESS | 1653 | 2017-02-09 01:53:50.572 plugin-container[1654:10020] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:54:00 INFO - PROCESS | 1653 | RSS: Main: 219049984 01:54:00 INFO - PROCESS | 1653 | 01:54:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 01:54:04 INFO - PROCESS | 1653 | RSS: Main: 233488384 01:54:04 INFO - PROCESS | 1653 | 01:54:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 01:54:07 INFO - PROCESS | 1653 | RSS: Main: 242233344 01:54:07 INFO - PROCESS | 1653 | 01:54:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 01:54:11 INFO - PROCESS | 1653 | RSS: Main: 245346304 01:54:11 INFO - PROCESS | 1653 | 01:54:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 01:54:14 INFO - PROCESS | 1653 | RSS: Main: 245379072 01:54:14 INFO - PROCESS | 1653 | 01:54:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:16 INFO - PROCESS | 1653 | RSS: Main: 246697984 01:54:16 INFO - PROCESS | 1653 | 01:54:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 01:54:20 INFO - PROCESS | 1653 | RSS: Main: 250343424 01:54:20 INFO - PROCESS | 1653 | 01:54:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 01:54:23 INFO - PROCESS | 1653 | RSS: Main: 249589760 01:54:23 INFO - PROCESS | 1653 | 01:54:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 01:54:27 INFO - PROCESS | 1653 | RSS: Main: 249307136 01:54:27 INFO - PROCESS | 1653 | 01:54:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:54:30 INFO - PROCESS | 1653 | RSS: Main: 248913920 01:54:30 INFO - PROCESS | 1653 | 01:54:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:54:32 INFO - PROCESS | 1653 | RSS: Main: 249393152 01:54:32 INFO - PROCESS | 1653 | 01:54:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:54:35 INFO - PROCESS | 1653 | RSS: Main: 248848384 01:54:35 INFO - PROCESS | 1653 | 01:54:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:54:39 INFO - PROCESS | 1653 | RSS: Main: 249204736 01:54:39 INFO - PROCESS | 1653 | 01:54:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:54:42 INFO - PROCESS | 1653 | RSS: Main: 249110528 01:54:42 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 01:54:44 INFO - PROCESS | 1653 | RSS: Main: 251039744 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | __start_tp_report 01:54:44 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 01:54:44 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 01:54:44 INFO - PROCESS | 1653 | |i|pagename|runs| 01:54:44 INFO - PROCESS | 1653 | |0;ai-astar;118;122;120;138;151;119;124;170;173;167 01:54:44 INFO - PROCESS | 1653 | |1;audio-beat-detection;144;139;138;179;145;116;123;127;132;111 01:54:44 INFO - PROCESS | 1653 | |2;audio-dft;196;197;195;232;176;262;275;201;201;198 01:54:44 INFO - PROCESS | 1653 | |3;audio-fft;83;60;59;88;61;58;70;60;65;81 01:54:44 INFO - PROCESS | 1653 | |4;audio-oscillator;88;72;86;74;72;71;83;71;73;84 01:54:44 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;111;89;90;88;91;87;77;132;135;88 01:54:44 INFO - PROCESS | 1653 | |6;imaging-darkroom;129;107;152;152;98;98;98;98;97;98 01:54:44 INFO - PROCESS | 1653 | |7;imaging-desaturate;110;144;114;92;128;123;76;141;142;78 01:54:44 INFO - PROCESS | 1653 | |8;json-parse-financial;56;57;55;57;60;60;60;60;56;50 01:54:44 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;72;69;81;78;78;71;88;90;108;107 01:54:44 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;86;87;85;81;101;88;84;85;86;75 01:54:44 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;140;140;139;147;154;149;142;158;202;162 01:54:44 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;172;172;170;203;228;196;172;169;173;169 01:54:44 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;67;67;67;67;66;67;65;68;69 01:54:44 INFO - PROCESS | 1653 | __end_tp_report 01:54:44 INFO - PROCESS | 1653 | __start_cc_report 01:54:44 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,949 01:54:44 INFO - PROCESS | 1653 | __end_cc_report 01:54:44 INFO - PROCESS | 1653 | __startTimestamp1486634084827__endTimestamp 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | ------- Summary: start ------- 01:54:44 INFO - PROCESS | 1653 | Number of tests: 14 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:140.20 Median:144.50 stddev:22.97 (15.9%) stddev-sans-first:22.91 01:54:44 INFO - PROCESS | 1653 | Values: 118.0 122.0 120.0 138.0 151.0 119.0 124.0 170.0 173.0 167.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:138.50 stddev:19.13 (13.8%) stddev-sans-first:20.04 01:54:44 INFO - PROCESS | 1653 | Values: 144.0 139.0 138.0 179.0 145.0 116.0 123.0 127.0 132.0 111.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:213.30 Median:201.00 stddev:32.24 (16.0%) stddev-sans-first:33.58 01:54:44 INFO - PROCESS | 1653 | Values: 196.0 197.0 195.0 232.0 176.0 262.0 275.0 201.0 201.0 198.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:68.50 Median:67.50 stddev:11.37 (16.8%) stddev-sans-first:10.78 01:54:44 INFO - PROCESS | 1653 | Values: 83.0 60.0 59.0 88.0 61.0 58.0 70.0 60.0 65.0 81.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.50 stddev:6.93 (8.8%) stddev-sans-first:6.20 01:54:44 INFO - PROCESS | 1653 | Values: 88.0 72.0 86.0 74.0 72.0 71.0 83.0 71.0 73.0 84.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:88.00 stddev:20.12 (22.9%) stddev-sans-first:20.85 01:54:44 INFO - PROCESS | 1653 | Values: 111.0 89.0 90.0 88.0 91.0 87.0 77.0 132.0 135.0 88.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:98.00 stddev:22.89 (23.4%) stddev-sans-first:23.50 01:54:44 INFO - PROCESS | 1653 | Values: 129.0 107.0 152.0 152.0 98.0 98.0 98.0 98.0 97.0 98.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:114.80 Median:143.00 stddev:25.65 (17.9%) stddev-sans-first:27.15 01:54:44 INFO - PROCESS | 1653 | Values: 110.0 144.0 114.0 92.0 128.0 123.0 76.0 141.0 142.0 78.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.50 stddev:3.18 (5.4%) stddev-sans-first:3.35 01:54:44 INFO - PROCESS | 1653 | Values: 56.0 57.0 55.0 57.0 60.0 60.0 60.0 60.0 56.0 50.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:84.20 Median:78.00 stddev:14.05 (18.0%) stddev-sans-first:14.19 01:54:44 INFO - PROCESS | 1653 | Values: 72.0 69.0 81.0 78.0 78.0 71.0 88.0 90.0 108.0 107.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:6.51 (7.6%) stddev-sans-first:6.91 01:54:44 INFO - PROCESS | 1653 | Values: 86.0 87.0 85.0 81.0 101.0 88.0 84.0 85.0 86.0 75.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:153.30 Median:151.50 stddev:18.90 (12.5%) stddev-sans-first:19.42 01:54:44 INFO - PROCESS | 1653 | Values: 140.0 140.0 139.0 147.0 154.0 149.0 142.0 158.0 202.0 162.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.40 Median:172.50 stddev:20.04 (11.6%) stddev-sans-first:20.90 01:54:44 INFO - PROCESS | 1653 | Values: 172.0 172.0 170.0 203.0 228.0 196.0 172.0 169.0 173.0 169.0 01:54:44 INFO - PROCESS | 1653 | 01:54:44 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 01:54:44 INFO - PROCESS | 1653 | Values: 66.0 67.0 67.0 67.0 67.0 66.0 67.0 65.0 68.0 69.0 01:54:44 INFO - PROCESS | 1653 | -------- Summary: end -------- 01:54:44 INFO - PROCESS | 1653 | 01:54:45 INFO - TEST-INFO | 1653: exit 0 01:54:45 INFO - TEST-OK | kraken | took 61416ms 01:54:45 INFO - SUITE-END | took 1176s 01:54:46 INFO - Completed test suite (00:19:37) 01:54:46 INFO - javascript benchmark 01:54:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7222.411115131591, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.165087902585, 3274.7216486598622, 3314.303996160806, 3317.1872891141675, 3321.883734069307, 5492.176173573966, 5542.861428464285, 5596.972015139923, 5606.943930560693, 5623.831285061445, 5555.3611334696525, 5618.213450116987, 5641.661500309984, 5692.117721753135, 5694.402087780785, 4850.733209673466, 5126.641135120543, 5161.9483805162035, 5191.662541934762, 5215.21771734241, 5204.089284375238, 5215.687058776485, 5224.791008359661, 5227.32044834171, 5230.973845130769, 5060.645754797166, 5089.949100508985, 5205.713685747282, 5214.817481388152, 5265.921011184835, 5152.021115987969, 5178.119719647669, 5191.039657663326, 5211.661242019257, 5266.289050978107, 5023.89254810795, 5152.92270615941, 5154.974225128851, 5175.0, 5240.423553409122, 5434.994526012701, 5597.3003374578175, 5619.325680918275, 5740.942590574083, 5742.339630942453, 6035.668038257894, 6124.203853499017, 6139.829471381233, 6143.4470897618985, 6193.659348735818, 5607.551395888319, 5879.235699359056, 6248.9062664060075, 6261.342559031282, 6265.279492858334, 5745.540356771448, 5763.135529670583, 5765.164051212592, 5772.2496075510335, 5780.653160810365, 6140.631562106288, 6183.072539119168, 6192.318844927055, 6208.379162083846, 6216.906746398808, 6008.819735407945, 6074.757009719562, 6089.939100608937, 6103.664298463627, 6115.118650813375, 6131.172291740647, 6197.03945888388, 6215.906761398583, 6219.968900155471, 6246.187995560548, 5961.761529538857, 6011.969940150271, 6116.816495505142, 6121.788327166048, 6142.1893435155225, 6187.257529096447, 6215.160953271251, 6227.532935029801, 6229.314775374705, 6246.562740608114, 4955.826546070943, 4960.330355402047, 4972.701637901738, 4983.5763960063805, 4994.051130285234, 4302.0, 4337.9783101084295, 4357.673174511924, 4416.24923762961, 4442.555744425532, 5657.462541058593, 5705.62913410627, 5775.797847075332, 5791.594588378857, 5815.331236907809, 5191.831837836532, 6176.66028368435, 6205.503559715302, 6218.844528886814, 6220.782272620437, 5539.695316757617, 5578.191162281528, 5580.972095139498, 5588.413216612278, 5619.8595035123635, 5369.060414427459, 5381.811636592701, 5385.892282154335, 5398.6220964532895, 5418.891622167614, 6201.317855035943, 6215.595986260879, 6219.502439804895, 6224.253089629274, 6230.906536402048, 6108.11432342299, 6141.946315431794, 6172.629642221302, 6185.134081228722, 6210.5652604317265, 6201.255849298113, 6263.09185168139, 6265.74937002533, 6267.2479302484, 6283.37166283368, 5179.559737422362, 5806.535477161732, 6188.783392581238, 6191.876162476815, 6213.1922850029205, 5865.589408741347, 6098.817035488943, 6127.234095738033, 6199.783007594712, 6200.875982480416, 4537.296719008559, 6014.158017877413, 6051.9711649020655, 6064.272287325549, 6079.118527813531, 5959.67221802805, 6011.489023432882, 6033.879322413615, 6035.728392222272, 6043.425874541911, 5002.774875130555, 5560.527355174693, 5732.484076433141, 5776.884462310814, 5898.056310990392, 5978.491828194652, 5993.730282137227, 6013.819585412444, 6115.635867915819, 6136.7948077883175, 5894.587378883437, 5931.228940237914, 5938.346781853907, 5955.880882382241, 5973.49225315853], "value": 5619.907700516755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.28581056457205, 496.7119070938854, 503.11451844753225, 509.9541041306282, 529.753664545986, 38230.61769382306, 41510.377344339824, 41521.16957660849, 41660.37509437361, 41675.0, 41481.377779333336, 41682.74951751445, 42140.57859421405, 42215.577844221545, 42223.788881055625, 6622.37087476689, 8694.782630434227, 9078.727638170865, 9346.532673366339, 9348.813023739522, 11109.277896936714, 11387.658370248906, 11419.828702569468, 11539.076873850072, 11550.249233799817, 11328.943355283212, 11377.601783937564, 11463.0, 11470.25443346184, 11474.770504589904, 11318.377489238088, 11350.772984540345, 11414.885851141507, 11426.542938282459, 11450.484728187252, 11317.660470185907, 11357.204995650307, 11381.260218085881, 11432.485538150802, 11435.42822858862, 40745.0, 40960.0, 40989.0, 41240.76277711673, 41248.587514124774, 3896.279188350164, 3897.2595206910596, 3933.2920074386598, 3975.4434379186937, 3980.681545476355, 27082.864585677144, 27110.1866943992, 27189.728102719117, 27221.047263345885, 28293.434131317463, 2774.6531683539556, 2988.9701102989125, 3150.6534281229046, 3231.6122065352074, 3258.462353711635, 480439.5978020122, 480669.0, 483690.5815470935, 485171.0, 485617.5719121417, 56631.150532742045, 56973.86052278931, 56976.14535781967, 57031.71484142553, 57088.0, 56371.15443268272, 56561.0, 56582.0, 57109.714451428306, 57227.0, 15790.447334343244, 15987.44043958479, 16033.518994429953, 16093.678126437406, 16124.03255804632, 11189.608363707232, 11388.544458221579, 12144.635660930186, 12329.568465103679, 12360.938195308965, 17936.55158621019, 18088.819111808978, 18115.003674798012, 18122.45632630997, 18156.0, 7296.927030729731, 7540.585267810323, 7645.847083058307, 7701.730439434593, 7754.418418618626, 750.264740554249, 870.6691457246205, 904.9230815380635, 911.6581282019242, 914.7667344827026, 29573.704262957526, 30080.699193008226, 30512.694873050987, 31016.844915775728, 31135.065948021143, 1028.9125424339015, 1066.7173199102244, 1087.6030248959073, 1102.443266150589, 1148.2019996102629, 12634.747305053848, 15796.92101539485, 15804.288807003712, 15901.602459938595, 16103.0, 598777.0, 599264.0, 600590.0, 600617.0, 601422.0, 60266.0, 60555.69722151449, 60737.392626073175, 60831.69584152051, 60854.69572652109, 1400.0, 1424.985750142506, 1447.7466443372368, 1452.208546342246, 1455.0105927969082, 25805.870970645028, 29165.56251656269, 29702.108936731933, 29895.0, 30599.2350191247, 50814.74592627161, 51282.74358628183, 51284.48715512797, 51324.0, 51484.712882178246, 521399.0, 522343.0, 524175.0, 526974.0, 528196.0, 26110.73889261159, 26578.601320980586, 26875.193744187705, 27004.0, 27049.59425608578, 38965.80517097397, 43035.569644303156, 47048.0, 48163.31428399989, 48569.51430485791, 38523.80738096291, 38961.220775583766, 39387.0, 40546.783596492154, 40753.1849363017, 39033.41449878311, 39783.0, 39827.0, 40061.28111463751, 40552.797236013634, 37040.0, 37583.0, 37681.86954391373, 38049.2390152201, 38153.42769858399, 32817.50773738443, 34042.97871063872, 34635.13412164716, 34683.30633387368, 34820.26549992563, 25142.62286065674, 25243.799947286556, 25267.241982740547, 25355.61966570466, 25787.355316117246], "value": 20069.475044683757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.17292201800547, 353.9539859818223, 382.62120500704305, 388.6793395448756, 405.161316075723, 19039.52401189969, 19938.202471901106, 19988.000599969997, 20378.184872605096, 20620.48448788781, 20435.38693839187, 20542.794572054274, 21115.838628875405, 21169.788302116973, 21534.676979845313, 5006.399232092154, 5404.405515393303, 5653.1237658162945, 5828.533717302626, 5864.530837532987, 4922.286268491067, 5779.07534794433, 5853.356130825606, 5855.8536036599, 5865.178874957509, 5668.57485688573, 5776.335721392031, 5789.45000224978, 5924.555658325643, 6021.096835474692, 5161.303224064741, 5950.494207992326, 5978.133170690247, 5982.581219314649, 6013.819585412422, 5718.285214348207, 5919.970400148015, 5943.821685349447, 5944.316403613553, 5949.6430214187285, 13620.59138225845, 13703.794443083361, 19360.0, 25523.85142668566, 25841.870790646113, 2533.8606376649277, 2549.821512494126, 2598.3763896664855, 2629.6449979252748, 2642.748938850806, 9660.130588247092, 10170.796584068352, 10223.744406389826, 10530.473476326153, 10593.205509586813, 1747.3010795681703, 1839.9632007359778, 1864.459306801026, 1867.5517875709868, 1874.8406385457251, 109567.45216273947, 135314.32342838222, 136269.3186534061, 136390.0, 139323.30338348344, 12123.75752484963, 12144.817827732591, 12179.817302740466, 12321.260724356567, 12438.81341779874, 15868.761968570481, 16019.519414417586, 16038.599035024217, 16057.598560036093, 16089.919550402406, 8769.91230087691, 8971.551422428853, 9011.909880901107, 9099.363044586815, 9119.635214591475, 8656.956715216384, 8671.4363566368, 8674.6530138795, 8775.605097770487, 8825.823483530294, 4835.347228124158, 4884.340614017134, 4898.118338698997, 4932.284818701268, 4949.876253093629, 2022.6662600671018, 2086.35323049855, 2100.0864623888656, 2103.169248147004, 2105.126372555403, 996.3473924579412, 1006.411249419098, 1019.1591936652144, 1021.3565453764081, 1033.2715435617872, 18670.34653787138, 21085.57828843445, 21407.357779266647, 21550.245741398976, 21568.4607884801, 918.4213945214472, 1022.2537547590152, 1031.654395777408, 1066.642674703983, 1068.6641697877653, 10795.352278863293, 11127.554897804159, 11146.439498470221, 11171.720706982227, 11234.662960111209, 750900.0, 764150.0, 769967.0, 771056.0, 773880.0, 130195.0, 133235.0, 153360.0, 155267.22366388096, 166889.0, 741.8775901976113, 956.4739393333778, 1027.9691609251586, 1032.7418145463635, 1043.3166276089173, 15848.60378490547, 19580.0, 20214.898925505277, 20238.291659791837, 20328.491787705425, 49958.0, 59506.404935950086, 60433.69783151232, 60966.0, 61435.69282153561, 86911.0, 91537.0, 91828.54085729529, 91832.62251066105, 92137.53931230301, 6406.84676758188, 8280.130586288353, 8381.11998240176, 8484.872726908978, 8635.611397487253, 10773.946130269298, 11302.321860688386, 12350.75298494043, 12675.873241267838, 12804.679883003, 10776.568937242737, 10852.457377130953, 10956.123510119012, 10966.945165274123, 11454.255473394203, 10335.793284134426, 10850.348979061282, 10901.691796984413, 11221.0, 11310.60412885545, 11149.442527873736, 11230.719232019264, 11278.661640150809, 11403.885961140282, 11580.247283926517, 8389.622466989122, 8504.53225072627, 8568.228859402683, 8685.348598854986, 8688.174623410765, 7057.611831349325, 7474.617195818791, 7848.646810893638, 8078.9192108080515, 10760.0], "value": 9798.834740808461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.6413064668513, 1419.4606049701113, 1421.452740694832, 1428.3572392423405, 1440.042371822738, 7427.071616047994, 7692.538447693142, 7968.4023698222645, 8404.789880252989, 8417.957910210447, 7957.880631790514, 8234.547099909518, 8252.504849709021, 8326.167383261685, 8344.3741719371, 2074.543600407908, 2103.5161912760072, 2105.1895020417173, 2105.620988222119, 2112.5458026524293, 1861.5997560524484, 1938.4572319750423, 2050.63088644044, 2079.542500649862, 2085.582883423314, 1768.9823101769011, 2024.87850728956, 2096.224396973122, 2098.12927635032, 2103.295396042328, 2104.084723145437, 2111.092230340953, 2126.904289306985, 2131.1581925139562, 2136.861104028241, 2105.768365479796, 2148.215901196052, 2162.351294611626, 2170.4899348653053, 2185.9890700546553, 8241.175882411711, 8421.368397370221, 8444.619992100308, 8463.984321881351, 8478.194571515696, 4984.451710311862, 5116.283720279164, 5128.9230661540105, 5132.358455193101, 5145.768440420153, 2845.2460098074025, 2896.652401711808, 3349.1961929137074, 3380.8478618462227, 3384.170878134848, 1159.4695002596575, 1197.7903866823358, 1200.4717924113363, 1225.8528976522875, 1674.4306935641819, 10611.78776424475, 10738.731531711692, 10843.0, 10876.836847447295, 10951.178661600332, 4238.915221695611, 4400.73595584266, 4444.0, 4454.844080457168, 4466.865994020184, 7434.628268586549, 8475.618597163018, 8706.782330441789, 8710.69512567057, 8715.782105447415, 5065.898682026339, 5079.74601269935, 5081.18701007837, 5083.059633967728, 5084.745762711849, 4031.9920019995, 4557.065801510682, 4684.391029166255, 4710.9764451177525, 4721.834735784231, 3547.1309529165005, 3563.2873425314524, 3583.9104022399647, 3608.693261072838, 3618.5295911531334, 1059.5761695321778, 1075.542894269932, 1138.612871623652, 1138.8120960041665, 1139.4132022008673, 746.216472703659, 765.9080910290689, 781.2773184804147, 799.5322736199389, 818.8771684247291, 5368.221607866837, 5434.10337294342, 5483.8080667176455, 5588.720563971785, 5698.031334673115, 782.8473447677649, 930.0192881813771, 973.6105557776805, 994.6021591363512, 997.755549890267, 3515.226650136966, 3562.4656301554974, 3576.2668652926086, 3677.9264414711556, 3695.796731179811, 9365.953170234105, 9958.402495850272, 10144.391336519833, 10155.136813370798, 10156.644517441853, 9965.302428829913, 9998.25013124004, 10000.549975250986, 10032.749181270381, 10062.949685251528, 7757.26306000929, 7800.648970796327, 7824.960875195701, 7900.525968441912, 7918.604069796487, 5300.469953004668, 5371.758270877898, 5436.483534064258, 5458.890822183614, 5513.035218836768, 9086.772830679285, 9105.408148470593, 9184.908150918405, 9307.06929307064, 9322.207612352755, 8907.599158037774, 9255.167034966616, 9266.490343031199, 9337.0, 9388.57751401175, 5858.765649374148, 7158.534695244793, 7187.281271872771, 7189.676464559003, 7189.784306470814, 7707.961460192663, 7744.65149068282, 7787.727429539939, 7788.1433042366425, 7827.882581761164, 6857.177138743383, 6902.758403455855, 6927.3419025192525, 6984.895226571707, 7014.158301003912, 6627.237867645283, 6664.0, 6735.898961515483, 6752.662366881538, 6786.728530858711, 6160.845978850564, 6280.685965701605, 6366.77716279928, 6403.327650596807, 6406.519511036784, 4871.853844384674, 4876.4392094909535, 4885.267209918541, 4916.139675556835, 4929.13740095489, 4835.734034628129, 4891.33966914462, 4892.363992680928, 4966.329545511309, 4977.377827771528], "value": 4263.010664225322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.2918007433461, 357.33000623830316, 364.2969069695487, 369.43476480984094, 373.701039168665, 4672.859814205571, 5079.56823669988, 5306.469353064692, 5331.333583302087, 5375.731213439332, 4900.828471003516, 5065.4934506549325, 5082.440931497532, 5175.948240517594, 5209.921851172226, 3662.505561749156, 4105.404716316132, 4110.438033547248, 4143.81352839123, 4157.189348077111, 3612.6929211017095, 3954.1696243788697, 3995.981024838662, 4039.4950631171105, 4159.3968874513175, 3126.124685088179, 4022.034711669208, 4049.623128136433, 4084.1627466369323, 4137.524184718765, 4085.8774236772942, 4090.5295890972475, 4097.242010228118, 4104.91790164198, 4106.1992911382295, 3031.4998025325795, 3110.7666924980717, 3639.5814481334455, 3657.3359121599874, 3683.189698266404, 4868.610511159099, 4991.32617096691, 5105.438401775802, 5154.587632989352, 5161.948380516222, 3901.5708272090046, 4555.681102322838, 4581.885452863672, 4602.815887364502, 4650.419017445316, 5257.605679574047, 5342.4089316681375, 5629.324481062258, 5640.689762063085, 5676.0, 3266.7386609071455, 3440.8451619677176, 3723.94414083789, 3856.2094770571966, 3860.7104467164795, 5556.611037227396, 5868.219803493555, 5887.586089703201, 5926.229590153295, 5935.37678543751, 3847.34564137418, 3890.2414029264023, 3902.824372903169, 3912.882613521599, 3942.9605703942593, 3959.8614048508166, 3967.8412863485137, 3970.563238043813, 3974.642282194616, 3984.820683069269, 3604.8377822998027, 4247.17180149874, 4529.796159172845, 4578.24583841247, 4614.238650622677, 4545.159145558082, 5241.528262456321, 5417.864553386197, 5671.143622336768, 5744.195812586241, 1108.3017698849835, 1126.594426006637, 1277.086882878746, 1290.7547565962436, 1294.2752058846888, 736.9042024536776, 794.9920500795033, 819.0089991110823, 859.5873980489275, 864.0150228739242, 4955.82654607087, 4970.247463165287, 5009.398872135367, 5009.774560144802, 5025.763535226862, 4639.907201855944, 4831.685940413862, 5065.594752419797, 5546.972265138648, 5575.944240557624, 4685.437747470257, 4988.054658683044, 4991.625628077909, 5016.423111342169, 5023.447420783711, 2471.690004297689, 2654.9911033807416, 2729.7543221110195, 2890.6097676813783, 2908.8109272897195, 5082.771275292546, 5540.307461567304, 5749.511291540266, 5756.366799652035, 5757.712114394263, 5477.452254774491, 5986.49114825236, 5986.880262394728, 5987.856375402948, 6035.66803825785, 5989.850253743692, 5994.520438364921, 6008.549358798107, 6056.273247210363, 6103.267607887082, 5183.844484665466, 5517.834464966058, 5576.5817563683695, 5820.417958204315, 5841.342189303771, 4920.852374428773, 5775.393583673654, 5793.536517078539, 5798.246227990334, 5826.73779679907, 5178.741062946762, 5809.796657116981, 6029.909551356645, 6058.909116363347, 6065.6049108704365, 3296.8351582420305, 3677.8528858845348, 3910.4720862683175, 3925.4700615416555, 3952.26883026641, 4943.678660887031, 5087.440381557952, 5787.247657804459, 5813.360530341574, 5860.8571328590515, 5400.918986215289, 5606.943930560642, 5640.266765320482, 5643.463870932255, 5707.800226992035, 4757.904841903073, 5407.107827208624, 5572.777088916398, 5592.2170896075395, 5594.5384031026215, 4879.634027448026, 5071.797128114834, 5219.739013049409, 5344.679319240858, 5525.712201240256, 5416.620836541404, 5440.6735595864375, 5449.754761035842, 5612.635178713371, 5666.631668941505, 4577.793999269974, 5373.274607928036, 5518.847649416651, 5569.749361278833, 5639.379668236573], "value": 4073.3034067378203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.1273408239697, 698.4656737595737, 765.2271206081859, 815.213319147023, 830.5971603772167, 14245.572632821006, 15365.769513457279, 15383.846161538382, 15455.459058932925, 15461.30424130914, 13512.662183445418, 13599.18404895707, 13620.318984050782, 13628.591142265723, 13630.386632601532, 833.3624777045565, 848.2832006954114, 857.8670306102564, 861.2894362151219, 865.7402779166256, 851.9488830670149, 862.8188080503071, 863.2834747159842, 864.9922839891519, 869.7043005378171, 802.7029998900415, 860.9440386374897, 892.1747383670112, 893.2630579771715, 898.0570401078874, 890.0787684746257, 890.6570970176497, 891.790429249126, 895.0870112485294, 896.3232759266745, 655.0632595388593, 665.2383021440472, 667.0860920538844, 667.6961982298043, 667.9913330870372, 13956.302184890816, 14204.71590568183, 15261.160636165007, 15348.462803801925, 15499.845001549953, 11666.591669291534, 12682.619521414372, 13638.249896255702, 13897.235652039133, 13906.096103753223, 10311.43287119208, 11972.521099156023, 12317.876821231763, 12358.938205308916, 12675.239485630891, 3775.0, 4405.911881762347, 4417.660706567366, 4453.131639330332, 4610.400647915783, 80855.26906836755, 81194.0, 82008.58995705043, 100143.49928250312, 103462.48268758607, 10353.689389318333, 10442.738931526621, 10456.68629941103, 10713.678589642323, 10940.890591094147, 20744.0, 20871.060802263935, 21548.676769848465, 21577.352679419644, 21617.702937823782, 7474.065741782278, 7497.88753168692, 7547.396208303323, 7553.169151393342, 7652.69389224436, 4188.099558594856, 4243.427137336482, 4249.383839343278, 4256.127493863813, 4273.9358909616385, 3450.741194410429, 3477.0, 3494.598121216042, 3534.2401383702627, 3537.133402316449, 650.0541711809307, 651.0852252585125, 657.2999755260632, 658.8568833074612, 664.1697877652933, 576.3775122867294, 584.4249746931978, 605.12257227021, 612.3998481488167, 621.471749013335, 9801.754956126153, 10150.441725705157, 10325.896741032493, 10398.636047738293, 10526.684199474028, 682.617734068923, 682.6825526130373, 690.944724422045, 695.1033167214237, 701.5194591704699, 4772.546608072227, 4942.678725882806, 4954.1082605130705, 4970.179920313108, 4988.176950803149, 103694.0, 104723.0, 104800.47599761952, 105392.47303763432, 106497.93502065036, 62867.685661572315, 71025.22436939117, 75546.62226688831, 75974.0, 79557.0, 64190.35809641844, 72562.0, 73642.6317868418, 76336.61831690806, 77746.6112669433, 8647.947085985274, 10221.23340749432, 11015.779684406107, 11180.888191117985, 11228.270162439416, 46039.0, 49690.751546242034, 49926.0, 50368.74815626045, 52089.739551302, 60604.0, 69626.95559566712, 70138.0, 70666.6466667684, 71778.0, 12639.304838233986, 13150.60548183556, 13292.933535332262, 13361.799573006218, 13417.597472075462, 13684.452621895012, 14086.084404514084, 14361.64095897611, 14934.0, 14935.775963360342, 12834.358282085672, 13539.052266341261, 13540.526081587097, 13704.2069168023, 13717.314134293047, 13159.934200328937, 13540.79688804649, 13619.918284471734, 13627.250501222528, 14192.92903535517, 12794.0, 12940.870591294342, 13252.0, 13441.260730659907, 13899.0, 10501.616591358597, 11190.657121145514, 11389.829152562885, 11408.771824563297, 11621.709457263636, 8546.529940853312, 9403.482808445327, 9805.983177273414, 10549.630762923261, 10967.287126336763], "value": 7395.044092945186, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 122.0, 120.0, 138.0, 151.0, 119.0, 124.0, 170.0, 173.0, 167.0], "value": 140.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 138.0, 179.0, 145.0, 116.0, 123.0, 127.0, 132.0, 111.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 195.0, 232.0, 176.0, 262.0, 275.0, 201.0, 201.0, 198.0], "value": 213.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 88.0, 61.0, 58.0, 70.0, 60.0, 65.0, 81.0], "value": 68.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 86.0, 74.0, 72.0, 71.0, 83.0, 71.0, 73.0, 84.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 89.0, 90.0, 88.0, 91.0, 87.0, 77.0, 132.0, 135.0, 88.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 107.0, 152.0, 152.0, 98.0, 98.0, 98.0, 98.0, 97.0, 98.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 144.0, 114.0, 92.0, 128.0, 123.0, 76.0, 141.0, 142.0, 78.0], "value": 114.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 57.0, 60.0, 60.0, 60.0, 60.0, 56.0, 50.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 81.0, 78.0, 78.0, 71.0, 88.0, 90.0, 108.0, 107.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 81.0, 101.0, 88.0, 84.0, 85.0, 86.0, 75.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 139.0, 147.0, 154.0, 149.0, 142.0, 158.0, 202.0, 162.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 170.0, 203.0, 228.0, 196.0, 172.0, 169.0, 173.0, 169.0], "value": 182.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 65.0, 68.0, 69.0], "value": 66.9, "unit": "score"}]}]} 01:54:46 INFO - Return code: 0 01:54:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:54:46 ERROR - # TBPL SUCCESS # 01:54:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:54:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:54:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:54:46 INFO - 2017-02-09 01:54:46.181 screenresolution[1658:10409] starting screenresolution argv=screenresolution get 01:54:46 INFO - 2017-02-09 01:54:46.183 screenresolution[1658:10409] Display 0: 1600x1200x32@60 01:54:46 INFO - 2017-02-09 01:54:46.189 screenresolution[1659:10412] starting screenresolution argv=screenresolution list 01:54:46 INFO - Available Modes on Display 0 01:54:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:54:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:54:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:54:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:54:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:54:46 INFO - Intel Iris: 01:54:46 INFO - Chipset Model: Intel Iris 01:54:46 INFO - Type: GPU 01:54:46 INFO - Bus: Built-In 01:54:46 INFO - VRAM (Dynamic, Max): 1536 MB 01:54:46 INFO - Vendor: Intel (0x8086) 01:54:46 INFO - Device ID: 0x0a2e 01:54:46 INFO - Revision ID: 0x0009 01:54:46 INFO - Displays: 01:54:46 INFO - Display: 01:54:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:54:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:54:46 INFO - Display Serial Number: 1600x1200 60 01:54:46 INFO - Main Display: Yes 01:54:46 INFO - Mirror: Off 01:54:46 INFO - Online: Yes 01:54:46 INFO - Rotation: Supported 01:54:46 INFO - Return code: 0 01:54:46 INFO - Running post-action listener: _resource_record_post_action 01:54:46 INFO - [mozharness: 2017-02-09 09:54:46.445311Z] Finished run-tests step (success) 01:54:46 INFO - Running post-run listener: _resource_record_post_run 01:54:46 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 38844928; Write bytes: 510968320; Read time: 246; Write time: 1613 01:54:46 INFO - TinderboxPrint: CPU usage
54.6% 01:54:46 INFO - TinderboxPrint: I/O read bytes / time
38,844,928 / 246 01:54:46 INFO - TinderboxPrint: I/O write bytes / time
510,968,320 / 1,613 01:54:46 INFO - TinderboxPrint: CPU idle
2,176.3 (45.4%) 01:54:46 INFO - TinderboxPrint: CPU system
972.6 (20.3%) 01:54:46 INFO - TinderboxPrint: CPU user
1,644.8 (34.3%) 01:54:46 INFO - TinderboxPrint: Swap in / out
246,951,936 / 0 01:54:46 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203305472; Write bytes: 198725632; Read time: 15788; Write time: 431 01:54:46 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 36874752; Write bytes: 301560320; Read time: 229; Write time: 1147 01:54:46 INFO - Running post-run listener: _upload_blobber_files 01:54:46 INFO - Blob upload gear active. 01:54:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:54:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:54:47 INFO - (blobuploader) - INFO - Open directory for files ... 01:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:49 INFO - (blobuploader) - INFO - Done attempting. 01:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:50 INFO - (blobuploader) - INFO - Done attempting. 01:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:51 INFO - (blobuploader) - INFO - Done attempting. 01:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:54 INFO - (blobuploader) - INFO - Done attempting. 01:54:54 INFO - (blobuploader) - INFO - Iteration through files over. 01:54:54 INFO - Return code: 0 01:54:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:54:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:54:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbe982b98947ac0821a29d43ca8079659f110b57d1374b4d89243ca6821d1b1ae3ef6843b3916c95994292dbb41ecd3678e3c5a0c8eb84450696903899a51fc8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a659a919055e17b3b984e0b64c8154261abdda2a87c132605164ad22b056e06c366a8d72d6fd98fc71b3089b9b4fba451c1b867ea704f6a59d6e73bd83c908", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3332ac8a3a074dc76cc13e0a83adc1c85b649a024f4e0f3d74e8ec48a658f01ec6c8d2a09539b86d7adde49ed1393283d483ab6c078a9b81f7261992983b6b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e09337f6b65e34ae89bd204ec291831e5241df7d82905231fb459ddf04b23ecdf45d83c8a1e20e1795e830f402aff6e6627899658d7cc8bf62efa6e0ec4b8efb"} 01:54:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:54:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:54:54 INFO - Contents: 01:54:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbe982b98947ac0821a29d43ca8079659f110b57d1374b4d89243ca6821d1b1ae3ef6843b3916c95994292dbb41ecd3678e3c5a0c8eb84450696903899a51fc8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a659a919055e17b3b984e0b64c8154261abdda2a87c132605164ad22b056e06c366a8d72d6fd98fc71b3089b9b4fba451c1b867ea704f6a59d6e73bd83c908", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3332ac8a3a074dc76cc13e0a83adc1c85b649a024f4e0f3d74e8ec48a658f01ec6c8d2a09539b86d7adde49ed1393283d483ab6c078a9b81f7261992983b6b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e09337f6b65e34ae89bd204ec291831e5241df7d82905231fb459ddf04b23ecdf45d83c8a1e20e1795e830f402aff6e6627899658d7cc8bf62efa6e0ec4b8efb"} 01:54:54 INFO - Running post-run listener: copy_logs_to_upload_dir 01:54:54 INFO - Copying logs to upload dir... 01:54:54 INFO - mkdir: /builds/slave/test/build/upload/logs 01:54:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.640645 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-09 01:54:54.696471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 01:54:54.701729) ========= 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.iMVgPLbpNT/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.zpujSqvYKE/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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/bbe982b98947ac0821a29d43ca8079659f110b57d1374b4d89243ca6821d1b1ae3ef6843b3916c95994292dbb41ecd3678e3c5a0c8eb84450696903899a51fc8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a659a919055e17b3b984e0b64c8154261abdda2a87c132605164ad22b056e06c366a8d72d6fd98fc71b3089b9b4fba451c1b867ea704f6a59d6e73bd83c908", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3332ac8a3a074dc76cc13e0a83adc1c85b649a024f4e0f3d74e8ec48a658f01ec6c8d2a09539b86d7adde49ed1393283d483ab6c078a9b81f7261992983b6b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e09337f6b65e34ae89bd204ec291831e5241df7d82905231fb459ddf04b23ecdf45d83c8a1e20e1795e830f402aff6e6627899658d7cc8bf62efa6e0ec4b8efb"} build_url:https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010972 build_url: 'https://queue.taskcluster.net/v1/task/UqpcEbEySv-5a1E8h--tQg/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/bbe982b98947ac0821a29d43ca8079659f110b57d1374b4d89243ca6821d1b1ae3ef6843b3916c95994292dbb41ecd3678e3c5a0c8eb84450696903899a51fc8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a659a919055e17b3b984e0b64c8154261abdda2a87c132605164ad22b056e06c366a8d72d6fd98fc71b3089b9b4fba451c1b867ea704f6a59d6e73bd83c908", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3332ac8a3a074dc76cc13e0a83adc1c85b649a024f4e0f3d74e8ec48a658f01ec6c8d2a09539b86d7adde49ed1393283d483ab6c078a9b81f7261992983b6b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e09337f6b65e34ae89bd204ec291831e5241df7d82905231fb459ddf04b23ecdf45d83c8a1e20e1795e830f402aff6e6627899658d7cc8bf62efa6e0ec4b8efb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 01:54:54.740825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:54:54.741230) ========= 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.iMVgPLbpNT/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.zpujSqvYKE/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.004550 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:54:54.794173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 01:54:54.794542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 01:54:54.795028) ========= ========= Total master_lag: 4.49 =========