builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0085 starttime: 1486524284.46 results: success (0) buildid: 20170207183603 builduid: 96156c92a788452fb0936644a450f9e1 revision: 644301c96f60cc9f7813afd53be1f349bab78242 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.465022) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.465459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.465732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.490130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.490529) ========= 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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-07 19:24: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% 8.02M=0.001s 2017-02-07 19:24:44 (8.02 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088730 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.605421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.605754) ========= 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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.020631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:44.654071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 19:24:44.657453) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 644301c96f60cc9f7813afd53be1f349bab78242 --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 644301c96f60cc9f7813afd53be1f349bab78242 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-07 19:24:44,743 truncating revision to first 12 chars 2017-02-07 19:24:44,744 Setting DEBUG logging. 2017-02-07 19:24:44,744 attempt 1/10 2017-02-07 19:24:44,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/644301c96f60?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 19:24:45,862 unpacking tar archive at: mozilla-aurora-644301c96f60/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372844 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 19:24:46.075781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:46.076101) ========= script_repo_revision: 644301c96f60cc9f7813afd53be1f349bab78242 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:46.076505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:46.076775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 19:24:46.096070) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-07 19:24:46.096365) ========= /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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:24:46 INFO - MultiFileLogger online at 20170207 19:24:46 in /builds/slave/test 19:24:46 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 19:24:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:24:46 INFO - {'append_to_log': False, 19:24:46 INFO - 'base_work_dir': '/builds/slave/test', 19:24:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:24:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:24:46 INFO - 'branch': 'Mozilla-Aurora', 19:24:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:24:46 INFO - 'config_files': ('talos/mac_config.py',), 19:24:46 INFO - 'default_actions': ('clobber', 19:24:46 INFO - 'read-buildbot-config', 19:24:46 INFO - 'download-and-extract', 19:24:46 INFO - 'populate-webroot', 19:24:46 INFO - 'create-virtualenv', 19:24:46 INFO - 'install', 19:24:46 INFO - 'run-tests'), 19:24:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:24:46 INFO - 'download_minidump_stackwalk': True, 19:24:46 INFO - 'download_symbols': 'ondemand', 19:24:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:24:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:24:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:24:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:24:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:24:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:24:46 INFO - 'installer_path': 'installer.exe', 19:24:46 INFO - 'log_level': 'info', 19:24:46 INFO - 'log_name': 'talos', 19:24:46 INFO - 'log_to_console': True, 19:24:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:24:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:24:46 INFO - 'opt_config_files': (), 19:24:46 INFO - 'pip_index': False, 19:24:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:24:46 INFO - 'cmd': ('bash', 19:24:46 INFO - '-c', 19:24:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:24:46 INFO - 'enabled': True, 19:24:46 INFO - 'halt_on_failure': False, 19:24:46 INFO - 'name': 'check_screen_resolution'},), 19:24:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:24:46 INFO - 'cmd': ('bash', 19:24:46 INFO - '-c', 19:24:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:24:46 INFO - 'enabled': True, 19:24:46 INFO - 'halt_on_failure': False, 19:24:46 INFO - 'name': 'check_screen_resolution'},), 19:24:46 INFO - 'run_cmd_checks_enabled': True, 19:24:46 INFO - 'sps_profile': False, 19:24:46 INFO - 'sps_profile_interval': 0, 19:24:46 INFO - 'suite': 'dromaeojs-e10s', 19:24:46 INFO - 'system_bits': '32', 19:24:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:24:46 INFO - 'title': 't-yosemite-r7-0085', 19:24:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:24:46 INFO - 'use_talos_json': True, 19:24:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:24:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:24:46 INFO - 'work_dir': 'build'} 19:24:46 INFO - [mozharness: 2017-02-08 03:24:46.304595Z] Running clobber step. 19:24:46 INFO - Running pre-action listener: _resource_record_pre_action 19:24:46 INFO - Running main action method: clobber 19:24:46 INFO - rmtree: /builds/slave/test/build 19:24:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:24:46 INFO - Running post-action listener: _resource_record_post_action 19:24:46 INFO - [mozharness: 2017-02-08 03:24:46.947595Z] Finished clobber step (success) 19:24:46 INFO - [mozharness: 2017-02-08 03:24:46.947762Z] Running read-buildbot-config step. 19:24:46 INFO - Running pre-action listener: _resource_record_pre_action 19:24:46 INFO - Running main action method: read_buildbot_config 19:24:46 INFO - Using buildbot properties: 19:24:46 INFO - { 19:24:46 INFO - "project": "", 19:24:46 INFO - "product": "firefox", 19:24:46 INFO - "script_repo_revision": "production", 19:24:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:24:46 INFO - "repository": "", 19:24:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:24:46 INFO - "buildid": "20170207183603", 19:24:46 INFO - "pgo_build": "False", 19:24:46 INFO - "basedir": "/builds/slave/test", 19:24:46 INFO - "buildnumber": 51, 19:24:46 INFO - "slavename": "t-yosemite-r7-0085", 19:24:46 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:24:46 INFO - "platform": "yosemite_r7", 19:24:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:24:46 INFO - "branch": "mozilla-aurora", 19:24:46 INFO - "repo_path": "releases/mozilla-aurora", 19:24:46 INFO - "revision": "644301c96f60cc9f7813afd53be1f349bab78242", 19:24:46 INFO - "stage_platform": "macosx64", 19:24:46 INFO - "builduid": "96156c92a788452fb0936644a450f9e1", 19:24:46 INFO - "slavebuilddir": "test" 19:24:46 INFO - } 19:24:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 19:24:46 INFO - Running post-action listener: _resource_record_post_action 19:24:46 INFO - [mozharness: 2017-02-08 03:24:46.951319Z] Finished read-buildbot-config step (success) 19:24:46 INFO - [mozharness: 2017-02-08 03:24:46.951460Z] Running download-and-extract step. 19:24:46 INFO - Running pre-action listener: _resource_record_pre_action 19:24:46 INFO - Running main action method: download_and_extract 19:24:46 INFO - mkdir: /builds/slave/test/build/tests 19:24:46 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')]} 19:24:46 INFO - trying https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 19:24:46 INFO - Downloading https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/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 19:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/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 19:24:48 INFO - Downloaded 1199 bytes. 19:24:48 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 19:24:48 INFO - Using the following test package requirements: 19:24:48 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 19:24:48 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 19:24:48 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 19:24:48 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'jsshell-mac.zip'], 19:24:48 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 19:24:48 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 19:24:48 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 19:24:48 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 19:24:48 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 19:24:48 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:24:48 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 19:24:48 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:24:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 19:24:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:24:48 INFO - Fetch https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 19:24:49 INFO - Expected file size: 16357303 19:24:49 INFO - Obtained file size: 16357303 19:24:55 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 19:24:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 19:24:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:24:55 INFO - Fetch https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 19:24:56 INFO - Expected file size: 16357303 19:24:56 INFO - Obtained file size: 16357303 19:25:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 19:25:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:25:03 INFO - Fetch https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 19:25:07 INFO - Expected file size: 14403485 19:25:07 INFO - Obtained file size: 14403485 19:25: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')]} 19:25:08 INFO - trying https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:25:08 INFO - Downloading https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 19:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/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 19:25:10 INFO - Downloaded 73820173 bytes. 19:25:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:25:10 INFO - mkdir: /builds/slave/test/properties 19:25:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:25:10 INFO - Writing to file /builds/slave/test/properties/build_url 19:25:10 INFO - Contents: 19:25:10 INFO - build_url:https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:25:10 INFO - Running post-action listener: _resource_record_post_action 19:25:10 INFO - Running post-action listener: set_extra_try_arguments 19:25:10 INFO - [mozharness: 2017-02-08 03:25:10.939182Z] Finished download-and-extract step (success) 19:25:10 INFO - [mozharness: 2017-02-08 03:25:10.939324Z] Running populate-webroot step. 19:25:10 INFO - Running pre-action listener: _resource_record_pre_action 19:25:10 INFO - Running main action method: populate_webroot 19:25:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:25:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:25:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:25:10 INFO - '--tppagecycles', 19:25:10 INFO - '7'], 19:25:10 INFO - 'tests': ['tsvgm']}}, 19:25:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:25:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:25:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:25:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:25:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:25:10 INFO - 'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:25:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:25:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:25:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:25:10 INFO - 'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['damp', 'tps']}, 19:25:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:25:10 INFO - 'tests': ['damp', 'tps']}, 19:25:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['dromaeo_dom']}, 19:25:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:25:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['basic_compositor_video']}, 19:25:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:25:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['a11yr', 19:25:10 INFO - 'ts_paint', 19:25:10 INFO - 'tpaint', 19:25:10 INFO - 'sessionrestore', 19:25:10 INFO - 'sessionrestore_no_auto_restore', 19:25:10 INFO - 'tabpaint']}, 19:25:10 INFO - 'other-e10s': {'tests': ['a11yr', 19:25:10 INFO - 'ts_paint', 19:25:10 INFO - 'tpaint', 19:25:10 INFO - 'sessionrestore', 19:25:10 INFO - 'sessionrestore_no_auto_restore', 19:25:10 INFO - 'tabpaint']}, 19:25:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:25:10 INFO - 'ts_paint', 19:25:10 INFO - 'tpaint', 19:25:10 INFO - 'sessionrestore', 19:25:10 INFO - 'sessionrestore_no_auto_restore', 19:25:10 INFO - 'tabpaint']}, 19:25:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:25:10 INFO - 'ts_paint', 19:25:10 INFO - 'tpaint', 19:25:10 INFO - 'sessionrestore', 19:25:10 INFO - 'sessionrestore_no_auto_restore', 19:25:10 INFO - 'tabpaint']}, 19:25:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['a11yr', 19:25:10 INFO - 'ts_paint', 19:25:10 INFO - 'tpaint', 19:25:10 INFO - 'sessionrestore', 19:25:10 INFO - 'sessionrestore_no_auto_restore', 19:25:10 INFO - 'tabpaint']}, 19:25:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['a11yr', 19:25:10 INFO - 'ts_paint', 19:25:10 INFO - 'tpaint', 19:25:10 INFO - 'sessionrestore', 19:25:10 INFO - 'sessionrestore_no_auto_restore', 19:25:10 INFO - 'tabpaint']}, 19:25:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['tsvgx', 19:25:10 INFO - 'tsvgr_opacity', 19:25:10 INFO - 'tart', 19:25:10 INFO - 'tscrollx', 19:25:10 INFO - 'cart', 19:25:10 INFO - 'tsvg_static']}, 19:25:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:25:10 INFO - 'tsvgr_opacity', 19:25:10 INFO - 'tart', 19:25:10 INFO - 'tscrollx', 19:25:10 INFO - 'cart', 19:25:10 INFO - 'tsvg_static']}, 19:25:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:25:10 INFO - 'talos_options': ['--disable-e10s'], 19:25:10 INFO - 'tests': ['tp5o']}, 19:25:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:25:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:25:10 INFO - 'talos_options': ['--disable-e10s', 19:25:10 INFO - '--xperf_path', 19:25:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:25:10 INFO - 'tests': ['tp5n']}, 19:25:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:25:10 INFO - 'talos_options': ['--xperf_path', 19:25:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:25:10 INFO - 'tests': ['tp5n']}}, 19:25:10 INFO - 'talos.zip': {'path': '', 19:25:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:25:10 INFO - Running post-action listener: _resource_record_post_action 19:25:10 INFO - [mozharness: 2017-02-08 03:25:10.957965Z] Finished populate-webroot step (success) 19:25:10 INFO - [mozharness: 2017-02-08 03:25:10.958094Z] Running create-virtualenv step. 19:25:10 INFO - Running pre-action listener: _resource_record_pre_action 19:25:10 INFO - Running main action method: create_virtualenv 19:25:10 INFO - Creating virtualenv /builds/slave/test/build/venv 19:25:10 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 19:25:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:25:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:25:11 INFO - Using real prefix '/tools/python27' 19:25:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:25:11 INFO - Installing distribute.............................................................................................................................................................................................done. 19:25:14 INFO - Installing pip.................done. 19:25:14 INFO - Return code: 0 19:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:25:14 INFO - Reading from file tmpfile_stdout 19:25:14 INFO - Output received: 19:25:14 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) 19:25:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:25:14 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')]} 19:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:14 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')]} 19:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:14 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 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:14 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 19:25:14 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 19:25:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:14 INFO - 'HOME': '/Users/cltbld', 19:25:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:14 INFO - 'LOGNAME': 'cltbld', 19:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:14 INFO - 'MOZ_NO_REMOTE': '1', 19:25:14 INFO - 'NO_EM_RESTART': '1', 19:25:14 INFO - 'PAGER': '/bin/cat', 19:25:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:14 INFO - 'PWD': '/builds/slave/test', 19:25:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:14 INFO - 'SHELL': '/bin/bash', 19:25:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:14 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:14 INFO - 'USER': 'cltbld', 19:25:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:14 INFO - 'XPC_FLAGS': '0x0', 19:25:14 INFO - 'XPC_SERVICE_NAME': '0', 19:25:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:25:15 INFO - Cleaning up... 19:25:15 INFO - Return code: 0 19:25:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:15 INFO - 'HOME': '/Users/cltbld', 19:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:15 INFO - 'LOGNAME': 'cltbld', 19:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:15 INFO - 'MOZ_NO_REMOTE': '1', 19:25:15 INFO - 'NO_EM_RESTART': '1', 19:25:15 INFO - 'PAGER': '/bin/cat', 19:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:15 INFO - 'PWD': '/builds/slave/test', 19:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:15 INFO - 'SHELL': '/bin/bash', 19:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:15 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:15 INFO - 'USER': 'cltbld', 19:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:15 INFO - 'XPC_FLAGS': '0x0', 19:25:15 INFO - 'XPC_SERVICE_NAME': '0', 19:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:15 INFO - Downloading/unpacking psutil>=3.1.1 19:25:15 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 19:25:15 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 19:25:15 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 19:25:15 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 19:25:15 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 19:25:15 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 19:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:25:19 INFO - Installing collected packages: psutil 19:25:19 INFO - Running setup.py install for psutil 19:25:19 INFO - building 'psutil._psutil_osx' extension 19:25:19 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 19:25:19 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 19:25:19 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 19:25:19 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 19:25:19 INFO - building 'psutil._psutil_posix' extension 19:25:19 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 19:25:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:25:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:25:19 INFO - ^ 19:25:19 INFO - 1 warning generated. 19:25:19 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 19:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:25:19 INFO - Successfully installed psutil 19:25:19 INFO - Cleaning up... 19:25:19 INFO - Return code: 0 19:25:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:19 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 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:19 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 19:25:19 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 19:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:19 INFO - 'HOME': '/Users/cltbld', 19:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:19 INFO - 'LOGNAME': 'cltbld', 19:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:19 INFO - 'MOZ_NO_REMOTE': '1', 19:25:19 INFO - 'NO_EM_RESTART': '1', 19:25:19 INFO - 'PAGER': '/bin/cat', 19:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:19 INFO - 'PWD': '/builds/slave/test', 19:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:19 INFO - 'SHELL': '/bin/bash', 19:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:19 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:19 INFO - 'USER': 'cltbld', 19:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:19 INFO - 'XPC_FLAGS': '0x0', 19:25:19 INFO - 'XPC_SERVICE_NAME': '0', 19:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:25:20 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 19:25:20 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 19:25:20 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 19:25:20 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 19:25:20 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 19:25:20 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 19:25:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:25:22 INFO - Installing collected packages: mozsystemmonitor 19:25:22 INFO - Running setup.py install for mozsystemmonitor 19:25:23 INFO - Successfully installed mozsystemmonitor 19:25:23 INFO - Cleaning up... 19:25:23 INFO - Return code: 0 19:25:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:25: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')]} 19:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25: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')]} 19:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25: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', '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 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:25: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 jsonschema==2.5.1 19:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:23 INFO - 'HOME': '/Users/cltbld', 19:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:23 INFO - 'LOGNAME': 'cltbld', 19:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:23 INFO - 'MOZ_NO_REMOTE': '1', 19:25:23 INFO - 'NO_EM_RESTART': '1', 19:25:23 INFO - 'PAGER': '/bin/cat', 19:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:23 INFO - 'PWD': '/builds/slave/test', 19:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:23 INFO - 'SHELL': '/bin/bash', 19:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:23 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:23 INFO - 'USER': 'cltbld', 19:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:23 INFO - 'XPC_FLAGS': '0x0', 19:25:23 INFO - 'XPC_SERVICE_NAME': '0', 19:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:23 INFO - Downloading/unpacking jsonschema==2.5.1 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:25:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:25:26 INFO - warning: no files found matching '*.txt' 19:25:26 INFO - no previously-included directories found matching 'build' 19:25:26 INFO - no previously-included directories found matching 'dist' 19:25:26 INFO - no previously-included directories found matching '.git*' 19:25:26 INFO - Installing collected packages: jsonschema, functools32 19:25:26 INFO - Running setup.py install for functools32 19:25:26 INFO - warning: no files found matching '*.txt' 19:25:26 INFO - no previously-included directories found matching 'build' 19:25:26 INFO - no previously-included directories found matching 'dist' 19:25:26 INFO - no previously-included directories found matching '.git*' 19:25:26 INFO - Successfully installed jsonschema functools32 19:25:26 INFO - Cleaning up... 19:25:26 INFO - Return code: 0 19:25:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:25: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')]} 19:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25: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')]} 19:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25: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', '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 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:25: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 functools32==3.2.3-2 19:25:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:26 INFO - 'HOME': '/Users/cltbld', 19:25:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:26 INFO - 'LOGNAME': 'cltbld', 19:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:26 INFO - 'MOZ_NO_REMOTE': '1', 19:25:26 INFO - 'NO_EM_RESTART': '1', 19:25:26 INFO - 'PAGER': '/bin/cat', 19:25:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:26 INFO - 'PWD': '/builds/slave/test', 19:25:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:26 INFO - 'SHELL': '/bin/bash', 19:25:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:26 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:26 INFO - 'USER': 'cltbld', 19:25:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:26 INFO - 'XPC_FLAGS': '0x0', 19:25:26 INFO - 'XPC_SERVICE_NAME': '0', 19:25:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:25:27 INFO - Cleaning up... 19:25:27 INFO - Return code: 0 19:25:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:25:27 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')]} 19:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:27 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')]} 19:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:27 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 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:27 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 19:25:27 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 19:25:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:27 INFO - 'HOME': '/Users/cltbld', 19:25:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:27 INFO - 'LOGNAME': 'cltbld', 19:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:27 INFO - 'MOZ_NO_REMOTE': '1', 19:25:27 INFO - 'NO_EM_RESTART': '1', 19:25:27 INFO - 'PAGER': '/bin/cat', 19:25:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:27 INFO - 'PWD': '/builds/slave/test', 19:25:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:27 INFO - 'SHELL': '/bin/bash', 19:25:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:27 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:27 INFO - 'USER': 'cltbld', 19:25:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:27 INFO - 'XPC_FLAGS': '0x0', 19:25:27 INFO - 'XPC_SERVICE_NAME': '0', 19:25:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:27 INFO - Downloading/unpacking blobuploader==1.2.4 19:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:29 INFO - Downloading blobuploader-1.2.4.tar.gz 19:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:25:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:25:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25:31 INFO - Downloading docopt-0.6.1.tar.gz 19:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:25:31 INFO - Installing collected packages: blobuploader, requests, docopt 19:25:31 INFO - Running setup.py install for blobuploader 19:25:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:25:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:25:31 INFO - Running setup.py install for requests 19:25:31 INFO - Running setup.py install for docopt 19:25:32 INFO - Successfully installed blobuploader requests docopt 19:25:32 INFO - Cleaning up... 19:25:32 INFO - Return code: 0 19:25:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:32 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')]} 19:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:32 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')]} 19:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:32 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 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:32 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 19:25:32 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 19:25:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:32 INFO - 'HOME': '/Users/cltbld', 19:25:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:32 INFO - 'LOGNAME': 'cltbld', 19:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:32 INFO - 'MOZ_NO_REMOTE': '1', 19:25:32 INFO - 'NO_EM_RESTART': '1', 19:25:32 INFO - 'PAGER': '/bin/cat', 19:25:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:32 INFO - 'PWD': '/builds/slave/test', 19:25:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:32 INFO - 'SHELL': '/bin/bash', 19:25:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:32 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:32 INFO - 'USER': 'cltbld', 19:25:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:32 INFO - 'XPC_FLAGS': '0x0', 19:25:32 INFO - 'XPC_SERVICE_NAME': '0', 19:25:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:25:32 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-GodCup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:25:32 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-M5S137-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:25:32 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-pwk2K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:25:32 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xrteWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:25:32 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-wtwKNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:25:32 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-3V8xIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-RDYDzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-MYmc5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Jz2hEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-cn5snD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-iyzajQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-r69Gfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-N7zjqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-2DZQ28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-eejbWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:25:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-x9in0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:25:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-HbBVQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:25:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:25:34 INFO - Running setup.py install for manifestparser 19:25:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:25:34 INFO - Running setup.py install for mozcrash 19:25:34 INFO - Running setup.py install for mozdebug 19:25:34 INFO - Running setup.py install for mozdevice 19:25:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:25:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:25:34 INFO - Running setup.py install for mozfile 19:25:34 INFO - Running setup.py install for mozhttpd 19:25:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Running setup.py install for mozinfo 19:25:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Running setup.py install for mozInstall 19:25:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Running setup.py install for mozleak 19:25:35 INFO - Running setup.py install for mozlog 19:25:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Running setup.py install for moznetwork 19:25:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:25:35 INFO - Running setup.py install for mozprocess 19:25:36 INFO - Running setup.py install for mozprofile 19:25:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:25:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:25:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:25:36 INFO - Running setup.py install for mozrunner 19:25:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:25:36 INFO - Running setup.py install for mozscreenshot 19:25:36 INFO - Running setup.py install for moztest 19:25:36 INFO - Running setup.py install for mozversion 19:25:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:25:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:25:36 INFO - Cleaning up... 19:25:36 INFO - Return code: 0 19:25:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:36 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')]} 19:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:36 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')]} 19:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:37 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 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:37 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 19:25:37 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 19:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:37 INFO - 'HOME': '/Users/cltbld', 19:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:37 INFO - 'LOGNAME': 'cltbld', 19:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:37 INFO - 'MOZ_NO_REMOTE': '1', 19:25:37 INFO - 'NO_EM_RESTART': '1', 19:25:37 INFO - 'PAGER': '/bin/cat', 19:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:37 INFO - 'PWD': '/builds/slave/test', 19:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:37 INFO - 'SHELL': '/bin/bash', 19:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:37 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:37 INFO - 'USER': 'cltbld', 19:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:37 INFO - 'XPC_FLAGS': '0x0', 19:25:37 INFO - 'XPC_SERVICE_NAME': '0', 19:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:25:37 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-G9UECc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:25:37 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)) 19:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:25:37 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-tmU0MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:25:37 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)) 19:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:25:37 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-qqm00O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:25:37 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)) 19:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:25:37 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Q0PwU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-LrnTW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-s5Jv2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:25:38 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)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Vf2vLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:25:38 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)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-UoeFoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:25:38 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)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-bXWm3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:25:38 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)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-0okPQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:25:38 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)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_RAFMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:25:38 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)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-f93ajc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:25:38 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)) 19:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:25:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-W7K50J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:25:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-rr_TQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-NgbSSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:39 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)) 19:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:25:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-nRq_Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:25:39 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)) 19:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:25:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-NYRmQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:25:39 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)) 19:25:39 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)) 19:25:39 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)) 19:25:39 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)) 19:25:39 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)) 19:25:39 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)) 19:25:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:42 INFO - Downloading blessings-1.6.tar.gz 19:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:25:42 INFO - Installing collected packages: blessings 19:25:42 INFO - Running setup.py install for blessings 19:25:42 INFO - Successfully installed blessings 19:25:42 INFO - Cleaning up... 19:25:42 INFO - Return code: 0 19:25:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:25:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:43 INFO - Reading from file tmpfile_stdout 19:25:43 INFO - Current package versions: 19:25:43 INFO - blessings == 1.6 19:25:43 INFO - blobuploader == 1.2.4 19:25:43 INFO - docopt == 0.6.1 19:25:43 INFO - functools32 == 3.2.3-2 19:25:43 INFO - jsonschema == 2.5.1 19:25:43 INFO - manifestparser == 1.1 19:25:43 INFO - mozInstall == 1.12 19:25:43 INFO - mozcrash == 1.0 19:25:43 INFO - mozdebug == 0.1 19:25:43 INFO - mozdevice == 0.49 19:25:43 INFO - mozfile == 1.2 19:25:43 INFO - mozhttpd == 0.7 19:25:43 INFO - mozinfo == 0.9 19:25:43 INFO - mozleak == 0.1 19:25:43 INFO - mozlog == 3.4 19:25:43 INFO - moznetwork == 0.27 19:25:43 INFO - mozprocess == 0.24 19:25:43 INFO - mozprofile == 0.28 19:25:43 INFO - mozrunner == 6.13 19:25:43 INFO - mozscreenshot == 0.1 19:25:43 INFO - mozsystemmonitor == 0.3 19:25:43 INFO - moztest == 0.8 19:25:43 INFO - mozversion == 1.4 19:25:43 INFO - psutil == 3.1.1 19:25:43 INFO - requests == 1.2.3 19:25:43 INFO - wsgiref == 0.1.2 19:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:43 INFO - 'HOME': '/Users/cltbld', 19:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:43 INFO - 'LOGNAME': 'cltbld', 19:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:43 INFO - 'MOZ_NO_REMOTE': '1', 19:25:43 INFO - 'NO_EM_RESTART': '1', 19:25:43 INFO - 'PAGER': '/bin/cat', 19:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:43 INFO - 'PWD': '/builds/slave/test', 19:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:43 INFO - 'SHELL': '/bin/bash', 19:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:43 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:43 INFO - 'USER': 'cltbld', 19:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:43 INFO - 'XPC_FLAGS': '0x0', 19:25:43 INFO - 'XPC_SERVICE_NAME': '0', 19:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:25:43 INFO - Cleaning up... 19:25:43 INFO - Return code: 0 19:25:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d3eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d41768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a1593af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, '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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 19:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:43 INFO - 'HOME': '/Users/cltbld', 19:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:43 INFO - 'LOGNAME': 'cltbld', 19:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:43 INFO - 'MOZ_NO_REMOTE': '1', 19:25:43 INFO - 'NO_EM_RESTART': '1', 19:25:43 INFO - 'PAGER': '/bin/cat', 19:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:43 INFO - 'PWD': '/builds/slave/test', 19:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:43 INFO - 'SHELL': '/bin/bash', 19:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:25:43 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:43 INFO - 'USER': 'cltbld', 19:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:43 INFO - 'XPC_FLAGS': '0x0', 19:25:43 INFO - 'XPC_SERVICE_NAME': '0', 19:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:25:43 INFO - Cleaning up... 19:25:43 INFO - Return code: 0 19:25:43 INFO - Running post-action listener: _resource_record_post_action 19:25:43 INFO - Running post-action listener: _start_resource_monitoring 19:25:43 INFO - Starting resource monitoring. 19:25:43 INFO - [mozharness: 2017-02-08 03:25:43.793190Z] Finished create-virtualenv step (success) 19:25:43 INFO - [mozharness: 2017-02-08 03:25:43.794146Z] Running install step. 19:25:43 INFO - Running pre-action listener: _resource_record_pre_action 19:25:43 INFO - Running main action method: install 19:25:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:44 INFO - Reading from file tmpfile_stdout 19:25:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:25:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:25:44 INFO - Reading from file tmpfile_stdout 19:25:44 INFO - Output received: 19:25:44 INFO - Usage: mozinstall [options] installer 19:25:44 INFO - Options: 19:25:44 INFO - -h, --help show this help message and exit 19:25:44 INFO - -d DEST, --destination=DEST 19:25:44 INFO - Directory to install application into. [default: 19:25:44 INFO - "/builds/slave/test"] 19:25:44 INFO - --app=APP Application being installed. [default: firefox] 19:25:44 INFO - mkdir: /builds/slave/test/build/application 19:25:44 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'] 19:25:44 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 19:26:04 INFO - Reading from file tmpfile_stdout 19:26:04 INFO - Output received: 19:26:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:26:04 INFO - Running post-action listener: _resource_record_post_action 19:26:04 INFO - [mozharness: 2017-02-08 03:26:04.035785Z] Finished install step (success) 19:26:04 INFO - [mozharness: 2017-02-08 03:26:04.035932Z] Running run-tests step. 19:26:04 INFO - Running pre-action listener: _resource_record_pre_action 19:26:04 INFO - Running main action method: run_tests 19:26:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:26:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:26:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:26:04 INFO - 2017-02-07 19:26:04.050 screenresolution[29694:273285] starting screenresolution argv=screenresolution get 19:26:04 INFO - 2017-02-07 19:26:04.053 screenresolution[29694:273285] Display 0: 1600x1200x32@60 19:26:04 INFO - 2017-02-07 19:26:04.058 screenresolution[29695:273288] starting screenresolution argv=screenresolution list 19:26:04 INFO - Available Modes on Display 0 19:26:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:26:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:26:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:26:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:26:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:26:04 INFO - Intel Iris: 19:26:04 INFO - Chipset Model: Intel Iris 19:26:04 INFO - Type: GPU 19:26:04 INFO - Bus: Built-In 19:26:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:26:04 INFO - Vendor: Intel (0x8086) 19:26:04 INFO - Device ID: 0x0a2e 19:26:04 INFO - Revision ID: 0x0009 19:26:04 INFO - Displays: 19:26:04 INFO - Display: 19:26:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:26:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:26:04 INFO - Display Serial Number: 1600x1200 60 19:26:04 INFO - Main Display: Yes 19:26:04 INFO - Mirror: Off 19:26:04 INFO - Online: Yes 19:26:04 INFO - Rotation: Supported 19:26:04 INFO - Return code: 0 19:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:26:04 INFO - Python 2.7.3 19:26:04 INFO - Return code: 0 19:26:04 INFO - grabbing minidump binary from tooltool 19:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1cd30>, '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 0x108a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b11be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:26:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:26:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:26:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:26:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:26:04 INFO - Return code: 0 19:26:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:26:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:26:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:26:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:26:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 19:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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 19:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f9PriAe6Wy/Render', 19:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:04 INFO - 'HOME': '/Users/cltbld', 19:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:04 INFO - 'LOGNAME': 'cltbld', 19:26:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:26:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:04 INFO - 'MOZ_NO_REMOTE': '1', 19:26:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:26:04 INFO - 'NO_EM_RESTART': '1', 19:26:04 INFO - 'PAGER': '/bin/cat', 19:26:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:04 INFO - 'PWD': '/builds/slave/test', 19:26:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:04 INFO - 'SHELL': '/bin/bash', 19:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PD9Qr2Vcus/Listeners', 19:26:04 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 19:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:04 INFO - 'USER': 'cltbld', 19:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:04 INFO - 'XPC_FLAGS': '0x0', 19:26:04 INFO - 'XPC_SERVICE_NAME': '0', 19:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 19:26:04 INFO - mozversion application_buildid: 20170207183603 19:26:04 INFO - mozversion application_changeset: 644301c96f60cc9f7813afd53be1f349bab78242 19:26:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:26:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:26:04 INFO - mozversion application_name: Firefox 19:26:04 INFO - mozversion application_remotingname: firefox-dev 19:26:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:26:04 INFO - mozversion application_vendor: Mozilla 19:26:04 INFO - mozversion application_version: 53.0a2 19:26:04 INFO - mozversion platform_buildid: 20170207183603 19:26:04 INFO - mozversion platform_changeset: 644301c96f60cc9f7813afd53be1f349bab78242 19:26:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:26:04 INFO - mozversion platform_version: 53.0a2 19:26:04 INFO - using testdate: 1486524364 19:26:04 INFO - actual date: 1486524364 19:26:04 INFO - starting webserver on 'localhost:49293' 19:26:04 INFO - SUITE-START | Running 2 tests 19:26:04 INFO - TEST-START | dromaeo_css 19:26:04 INFO - operating with platform_type : mac_ 19:26:04 INFO - Initialising browser for dromaeo_css test... 19:26:04 INFO - TEST-INFO | started process 29705 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpkzxg83/profile http://localhost:49293/getInfo.html) 19:26:07 INFO - PROCESS | 29705 | 2017-02-07 19:26:07.718 plugin-container[29707:273466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 19:26:07 INFO - PROCESS | 29705 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:26:07 INFO - PROCESS | 29705 | 2017-02-07 19:26:07.721 plugin-container[29707:273466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940f, name = 'com.apple.CFPasteboardClient' 19:26:07 INFO - PROCESS | 29705 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:26:07 INFO - PROCESS | 29705 | 2017-02-07 19:26:07.721 plugin-container[29707:273466] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:26:07 INFO - PROCESS | 29705 | __metrics Screen width/height:1600/1200 19:26:07 INFO - PROCESS | 29705 | colorDepth:24 19:26:07 INFO - PROCESS | 29705 | Browser inner width/height: 1024/689 19:26:07 INFO - PROCESS | 29705 | __metrics 19:26:07 ERROR - PROCESS | 29705 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 19:26:07 INFO - PROCESS | 29705 | 1486524367890 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/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpkzxg83/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpkzxg83/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpkzxg83/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpkzxg83/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:26:08 INFO - TEST-INFO | 29705: exit 0 19:26:08 INFO - Browser initialized. 19:26:08 INFO - Running cycle 1/1 for dromaeo_css test... 19:26:08 INFO - TEST-INFO | started process 29709 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpkzxg83/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:11 INFO - PROCESS | 29709 | 2017-02-07 19:26:11.021 plugin-container[29710:273602] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 19:26:11 INFO - PROCESS | 29709 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:26:11 INFO - PROCESS | 29709 | 2017-02-07 19:26:11.022 plugin-container[29710:273602] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 19:26:11 INFO - PROCESS | 29709 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:26:11 INFO - PROCESS | 29709 | 2017-02-07 19:26:11.022 plugin-container[29710:273602] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:26:20 INFO - PROCESS | 29709 | RSS: Main: 219279360 19:26:20 INFO - PROCESS | 29709 | 19:29:22 INFO - PROCESS | 29709 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49293/tests/dromaeo/cssquery-ext.html) 19:29:24 INFO - PROCESS | 29709 | RSS: Main: 236118016 19:29:24 INFO - PROCESS | 29709 | 19:31:08 INFO - PROCESS | 29709 | ************************* 19:31:08 INFO - PROCESS | 29709 | A coding exception was thrown and uncaught in a Task. 19:31:08 INFO - PROCESS | 29709 | 19:31:08 ERROR - PROCESS | 29709 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:31:08 INFO - PROCESS | 29709 | Full stack: 19:31:08 INFO - PROCESS | 29709 | ************************* 19:32:26 INFO - PROCESS | 29709 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-ext.html (next: http://localhost:49293/tests/dromaeo/cssquery-jquery.html) 19:32:27 INFO - PROCESS | 29709 | RSS: Main: 247058432 19:32:27 INFO - PROCESS | 29709 | 19:35:29 INFO - PROCESS | 29709 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49293/tests/dromaeo/cssquery-mootools.html) 19:35:29 INFO - PROCESS | 29709 | RSS: Main: 253313024 19:35:29 INFO - PROCESS | 29709 | 19:38:31 INFO - PROCESS | 29709 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49293/tests/dromaeo/cssquery-prototype.html) 19:38:32 INFO - PROCESS | 29709 | RSS: Main: 249749504 19:38:32 INFO - PROCESS | 29709 | 19:41:35 INFO - PROCESS | 29709 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49293/tests/dromaeo/cssquery-yui.html) 19:41:35 INFO - PROCESS | 29709 | RSS: Main: 253935616 19:41:35 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-yui.html (next: http://localhost:49293/tests/dromaeo/cssquery-dojo.html) 19:44:38 INFO - PROCESS | 29709 | RSS: Main: 255217664 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | __start_tp_report 19:44:38 INFO - PROCESS | 29709 | _x_x_mozilla_page_load 19:44:38 INFO - PROCESS | 29709 | _x_x_mozilla_page_load_details 19:44:38 INFO - PROCESS | 29709 | |i|pagename|runs| 19:44:38 INFO - PROCESS | 29709 | |0;dojo.html;3314.38683843489;3322.634510203876;3351.7318614510837;3363.5459213006243;3370.1574606348413;5551.916721249175;5738.7417566209515;5798.217240672513;5801.796937107202;5826.21346118275;5747.051736463489;5832.125181222818;5834.095715164156;5846.093855452401;5866.149408335799;5047.47001564836;5275.997560463509;5279.63042587019;5295.973520132394;5321.255024296602;4448.888777780549;4495.325701144821;5309.283246761695;5325.334333208349;5340.946590534084;5136.4606716295;5176.637635365526;5275.525202731754;5329.840104796862;5333.919991200135;5164.715940623264;5182.818601348972;5229.947700523022;5261.710605916673;5328.387235467893;4399.318105693623;5203.531682148587;5211.5049070338255;5233.241180028913;5238.685678859242;5587.944120558783;5710.942890571083;5761.251037365158;5768.942310576883;5830.096335068071;6132.233470816148;6139.829471381233;6182.84542886427;6186.072089186658;6188.412100850412;6215.906761398583;6224.564280500367;6231.283402408736;6242;6242.5942313749465;5776.815752770672;5806.44838740319;5808.8257352279925;5829.708514574254;5858.619189752652;6109.7387008107025;6182.412670796267;6204.472619827366;6222.377762223832;6251.3123556408755;6180;6188.226471691039;6218.657973811393;6220.688965551704;6226.470749986302;6240.781572645026;6241.750329986749;6244.687765611701;6249.187605611241;6259;6069.757209711651;6149.723262453201;6150.630962142286;6235.688215589294;6241.78153764616;6231;6254.593451425642;6258.718357673915;6284.4344009039405;6286;5027.2207807789855;5047.041062198171;5047.671901326402;5052.797888084436;5054.82308119214;4382.255016647177;4435.112977404532;4470.530594287553;4517.525659805673;4521.706089104197;5755.539556835443;5829.387914269026;5872.559558033079;5928.170056192136;5948.494377977834;6249.187605611332;6265.561410701298;6266.811995640138;6267.467265282411;6290.119383286344;4882.340883980688;4895.8041678332465;5612.719364031782;5738.741756620879;5804.332501762267;5514.255575497336;5528.170774383874;5532.059549876531;5539.612227144061;5543.6396634218645;6371.235451745728;6404;6406.295307516077;6407.038944158414;6416.743330266737;5281.313429254173;6136.641621527207;6140.28953073628;6169.413905678954;6187.504999599932;5122.462141475092;6459.128017717548;6461.450776683847;6463.192100987377;6481.125048118633;6164.31889890938;6209.565330427007;6235.3452887446165;6241.563090583615;6246.500279977682;6069.726862291119;6201.906971395523;6210.285817131088;6277.058441233851;6287.339829318039;6137.7447333336595;6206.286277078194;6209.751609935552;6230.470410015199;6247.406496382836;6153.84615384619;6186.690665466619;6215.65813880241;6237.376262373727;6240.126382306572;5558.972205138948;5781.537477001746;5897.410258974069;6032.8793424132145;6111.236095488064;6143.941779503737;6160;6164.907526387197;6257.968710156602;6276.744651069896;6098.9390106100145;6105.053716673922;6113.266408031065;6119.265688117454;6122.204113465221 19:44:38 INFO - PROCESS | 29709 | |1;ext.html;434.03860449105224;440.5924519819167;465.41357889059776;478.4808482796166;526.3972751199879;31398.215044623867;41488.170236595324;41542.961425964364;41617.58382416179;41962.790186049024;42529.57470425295;42532.14935701292;42842.57157428425;42947.14105717884;42960.35559466611;8371.246587807096;8554.871676924851;9128.087191280885;9376.718698439023;9380.624775008991;11084.224104312701;11413.201075924688;11425.42872856358;11558.826617600742;11568.363739994296;9824.410535367864;11455.656330310063;11464.71338216543;11478.253913495597;11495.19533632646;11350.545978160864;11356.48895799691;11364.545418183263;11387.715307117305;11477.024452921512;11268.323900565993;11367.204295699305;11373.715657108556;11374.772504549945;11384.203105782599;40513.79743101266;40847.38728919069;40885;40918.1816363674;41051.589484105076;3994.560598334181;4020.2562525932794;4066.5526792053147;4091.6317531422314;4116.197341518405;29337.973170939127;30000.399992000257;30010.549841752392;30904;31286.37427251465;3197;3285.162283617662;3314.5359649649067;3326.268220991378;3396.252824378633;481663;483483;487911.56044219906;488283;488941.1082390467;64724;65031.024534632015;65049;65189.69620607561;65258;68500.3149968494;68681.65659171672;68750.3124968754;68799.65600171968;69113.30886691068;16163.353465861233;16768.245428955724;16781.496555103367;16786.74819877703;16811.327546898232;11704.063674905987;11826.290422574673;12790.488380464863;12980.415881285366;13053.543125990545;14747.820174386023;15447.845521544641;16446.424375146813;17137.400190993256;17587.47237582849;6592.703328350236;7046.154461464657;7061.682224299919;7114.146302443636;7140.821479462951;733.1524558113631;865.9783505412415;870.2586851417957;900.819836032796;916.7295647783919;29231.56152657712;29978.250543736143;30246.395072098436;30922.226944326572;31201.531977020364;947.7251597036782;1043.2488608202082;1119.6081371519904;1125.7410795516914;1176.6940595445246;13659.453621855213;14642.04826686262;17611.647767044586;17613.844978317677;18042.09789510519;595768;596673;600041;602320;619009;54690;64306.678466607365;64477.355226448075;64797;65392.019119713244;1430.4349781836117;1449.1956963884934;1469.2286549561566;1473.1676602719429;1478.113132120719;29657.70342296636;32059.519107213877;32136;32514;32866.17834554155;53440.198397024855;54021;54033.72983135059;54110.64723381947;54156.72921635367;534885;535364;537253;539589;539965;36417.27165456623;37188.628113718514;42617.5738242626;43266.35100473558;44204.11591768211;46712.53287467082;47178.76410617925;47656.52343476521;48062;48561.5143848557;38732;39108.608913910495;39132.60867391404;39399.21201575895;39492.40761388639;32460.188495287806;39527;39529;40694.38958415685;40785.1842963145;37847.24305513819;38080.80959595184;38456.615433845305;38738.837834865;38790.41814372843;32074;34463.65536344604;34479.65520344764;34708.91746495218;34750;24460.87769561141;25140.62289065629;25598.744012560383;25858.741412586387;26298 19:44:38 INFO - PROCESS | 29709 | |2;jquery.html;350.33436470705664;380.7144641518861;391.82563759127163;410.91165399439114;421.65845665011324;17842.19710113045;20581.485462863435;21294.36116916495;22242.110315587397;22248.332550023504;12046.638600841967;12171.57399491018;12335.568255111073;12462.314572698499;12487.68780780481;5404.6486978346475;5614.045612245928;5614.9157762633595;5624.3531993820625;5631.690257035862;3708.592054873962;4072.2059198456313;5493.670379777206;6184.659843708594;6226.906596401058;6270.561060725751;6271.592346497463;6291.842703932415;6297.244330680325;6305.8108256752375;6065.363136870631;6196.535259855506;6230.59501132425;6297.929352010169;6322.968385158091;5943.692387674748;6121.540884433685;6135.171751813493;6152.2924863640355;6154.353792851775;21469;25744.356391090187;25932.87033564839;25949.091781787734;26627.334316642045;2681.8927242910454;2694.932626684329;2696.703362630109;2698.743619356158;2734.753872151496;9837.458939758311;10443.582256709722;10447.634332798392;10798.406087665175;10803.459827008697;1876.2495001999173;1901.7717873855088;1911.7801452832964;1924.6343194792944;1933.7679478462535;123843;125829.37085314606;126317;128048.35975820155;129951.35024325007;12009.039276857831;12099.879001209874;12150.696232594255;12276.631701048982;12332.445039973223;15913;15952.441664541686;15966.680666386606;16017;16032.599185020468;7548.358389536841;8770.736877893672;9088.545572721338;9213.170814626716;9281.675141370155;8797.868031979526;8805.339599530062;8811.603477843384;8939.73180804577;8954.86567701485;4835.443923948791;4924.8030078797165;4943.382077240345;4978.6017118630425;4993.725345105981;1545.961350966235;1701.651161511887;1788.4902802701167;2035.6844689073218;2082.3336532309518;1028.7273872423814;1033.927625066238;1065.9374111095055;1075.3332933581073;1084.8969347911936;20874.37376878696;20937.476563086046;20942.267020654508;21000.264990725253;21144.894275528524;1069.9411532365639;1081.5723245316265;1098.3464838421128;1103.0293341859112;1107.545906178463;10561;11093.33439993603;11098.61154859576;11141.610043648434;11164.776704465865;739086;747605;748879;754663;765433;110134;150002;156819.21590391974;158909;164850.9999999976;993.6273897288517;997.1972562087589;1067.2689207892463;1077.1490522487304;1080.5515710979855;19256.422307330802;19435.028248587798;19646.705299420806;19656.11547480338;19804.90097549503;41666.95832604209;59729.701351492964;59905.40094598998;61093.08360374687;61820;87686.12313877034;88409.55795220983;88452;90063;91195;5965.761369545169;8394.664213431395;8408.201220884006;8427;8673.739787806377;9315.534223288943;9796.9020309796;11239.932206440375;12423;13421.731565368442;8171;9420.38767480139;10956.397398142859;11025.17311201647;11030.613928512463;8397.580120994047;9383.343165978316;9629.32594718363;10923;11315.094792416423;10238.488075596339;10308.639197628347;11278.887211127783;11495.827562586735;11580.247283926517;8166.469179503313;8283.450572382964;8361.749147525585;8469.407141500036;8502.532360720219;8178.141295163922;9920.206383489447;10989.890101098887;11292.548298068314;11329.433528323716 19:44:38 INFO - PROCESS | 29709 | |3;mootools.html;1278.2138984524518;1433.8852891768654;1434.146682723779;1458.197991104892;1464.377639503211;7552.90482879982;7784.377249820015;8143.063547692017;8548.829023419528;8595.613197406115;8071.717489887855;8260.91739082609;8342.791430214247;8459.53472559009;8471.152884711526;2306.3657494189106;2354.458474550846;2357.292812156355;2360.36270207044;2361.4804742956608;2043.0397713074906;2077.9584408311825;2150.032485381577;2320.7331156917003;2369.609014512603;2260.4235919840416;2336.684547586071;2337.9883100584557;2349.4713689419827;2353.4234112642425;2311.04091801902;2314.652802079693;2330.1727886600183;2334.439734463725;2334.5447637710654;2310.1798861404127;2330.1611419888827;2383.1420688552107;2385.105585405473;2395.748446413119;8396.244338009546;8469.19542643454;8492.66029358825;8513.404061715682;8518.57407129641;5000.574951129159;5132.769025393829;5149.227615857614;5150.587952963754;5159.664621799571;3180;3312.685294896981;3368;3496.248306614065;3540.946885796715;1169.561414469574;1175.747214348919;1200.9159358844884;1256.8805963433458;1257.1262972234301;8666.39335246533;10408.219383546264;10959.945200273947;10983.780324393547;10991.285566438235;4667.743274119888;4721.645876559203;4739.478657347689;4776.2119250324;4787.257975013878;9562.474063926551;9567.37812042215;9590.808183836285;9624.181944534654;9633.807323853624;5204.167333226741;5282.418933917266;5291;5293.920591191135;5300.628955973122;4161.854335098257;4609.723416595015;4704.929426058612;4765.285207218945;4808.519148085164;3891.9416208756893;3898.590647981978;3957.8021098944937;3984.541777695544;3991.840326386912;1012.6658202793061;1083.8890137608855;1266.5946896992873;1305.1190446448609;1308.653206900172;859.8194379180317;859.9828003439897;871.9476831390136;883.4478450968145;885.1590988560893;5201.1678131498775;5876.676782776988;5934.13954976526;5992.730327135289;6094.908576371358;999.7750506136207;1001.114014097529;1024.3393011507535;1029.0584115534352;1059.3114475590928;3738.663520283133;3976.1650053489093;3981.6217459341315;4008.679305655599;4026.295398305285;9824.95087524572;10115.190784737204;10119.797604047877;10138.543765530421;10150.543225554868;9460.8580871287;9977.351472154287;10012.899871001197;10075.992400760011;10130.746731331628;7811.453198276066;7884.72403465876;7967.521948683214;7999;8019.518828870287;5057.216131499624;5591.916121258103;5643.463870932255;5680.857978550569;5771.451712087345;9091.999880013062;9269.53652317368;9317.673881414117;9340.71977840666;9383.01478344764;9238.260939124719;9304.860427093463;9524.285678574273;9551.235901128031;9559.761005974906;7230.45771567124;7311.049563556916;7328.450366222662;7353.411727061929;7357.301056399633;7708.3062524370835;7895.328897043815;7942.801429964297;7980.720674776355;7988.041435027834;7243.275672432715;7259.20148783644;7292.598907060163;7342.229065947999;7396.778096657109;7113.75101871432;7154.284571542804;7159.069320988238;7170;7238.877973914052;6457.063725759833;6566.9014964774615;6569.310222426577;6584.814733348044;6595.241547222131;4149.97925010373;4437.5784300491405;4974.477679843564;5011.473795251592;5131;4400;4979.516845842454;4994.850154495371;5136.691798492103;5183.948160518497 19:44:38 INFO - PROCESS | 29709 | |4;prototype.html;301.2483852787296;363.27345309381235;370.52387681828856;371.62465909431484;371.72492355656806;5242.397124330703;5328.280682107914;5334.5732341412695;5408.296921400222;5468.988237176125;4255.680823938209;4330.39374487572;4648.511906249846;5123.462036486171;5460.754266058027;3400.7927185848916;4274.551172126929;4286.099919017002;4291.892702682427;4294.334378171388;3727.3104475671953;4029.234445455354;4101.9589804102025;4106.38404239365;4165.958340416602;4067.9186416271655;4113.732607380525;4115.218108559379;4120.846163074344;4141.482314710661;3743.8315275812383;4119.588041195856;4120.711550191473;4138.399932009872;4165.645920096796;3122.3911337289237;3245.4259684053213;3327.6505966873374;3489.1333136771705;3599.748017638766;4811.254255590389;4937.111319962405;5283.207518872162;5300.330395925271;5321.467853214686;4682.08699303636;4703.976480117578;4722.622190224808;4724.5984091352275;4730.668853180278;5093.567046801027;5131.974340128313;5138.537531622172;5635.0138725723245;5748.856278593027;3938.704597155196;3949.526056873165;3961.3265744823448;3964.32606456903;3972.642462178389;5440;5447.918281225824;6078.300995385499;6088.299845517778;6170.210638914709;3784.5807822066727;3909.8465952544066;3931.9803400983383;3969.7419667721506;3973.3443981743267;3709.1995543364587;3996.860894645012;4024.6377825995214;4037.354023356249;4046.8785936421955;4688.929666055012;4699.718016918996;4709.811607535728;4718.386609740712;4778.784954677048;4765.26138448541;5359.356877174686;5680.488756011979;5795;5900.557458190653;1242.9062425066065;1253.473541112735;1273.0961017677553;1305.3943649311211;1308.5093090091216;832.8584140696096;850.2135524639807;867.7917299847991;881.4799268431656;886.3573908915985;4648.604868586141;4695.248760198352;5123.718195499208;5153.320273457781;5217.373915130132;5364.8122315718765;5529.474699903502;5710.7430165642645;5740.56945729072;5772.884542309131;4794.657495901153;4831.661783675179;5206.505381988705;5208.609354298367;5216.686998780086;2795.6784969728333;2928.092291389676;2976.4968690811;2991.012965721307;3001.2796928737384;4965.751712414365;5122.667026643257;5843.883122337529;5861.6189947653265;5900.940990590125;5415.106507426231;5552.639078459968;5792.190787468075;5826.213461182686;5863.70681465925;5292.338457692866;5671.427000989351;5728.455796699307;5861.681121747572;5864.654138344611;5095.24214146119;5213.60897932649;5340.519353258225;5637.238972738792;5732.16883551891;5609.205054382722;5647.745851436613;5656.151577263443;5721.599488035964;5767.423257674199;4976.701397915992;5487.670739755627;5538.584606154635;5769.336526299529;5883.235179426647;3246.626637936573;3329.716974057232;3384.830758462116;3621.092017203868;3821.8089095544556;5544.3346798384455;5594.69229192382;5632.493075623213;5665.518430933417;5672.681481333466;4565.726056436624;5624.312706188045;5802.158686990447;5822.446867547576;5840.123981402654;5744.655320680772;5781.710914454345;5782.554361409648;5792.756056608313;5794.159846822103;5304.814331498379;5326.816005437752;5567.137093750475;5635.971820140873;5674.460926212003;5399.78400863961;5669;5823.79616713413;5835.54111472132;5916.911246331222;4574.222382194968;4991.9001619966675;5378.542823859859;5648.745806438802;5751.309842818889 19:44:38 INFO - PROCESS | 29709 | |5;yui.html;652.4845372155996;731.2486941987606;733.189825243106;735.7755884455239;763.1795819494042;12953.575106738263;13426.731465370687;14530.636734081654;15170.84829151708;15572.844271557282;12737.745245095093;12836.294003829786;12924.676883077904;12964.027697922646;13291.136076155068;875.6803766625184;884.3941899798626;889.0442774017924;890.0165317324361;891.6121487153076;703.7747920665389;821.3183058061824;886.6364790435922;900.3022657440471;902.1519771414881;942.9434233945985;947.8578213267996;950.857371394293;951.7810903492201;953.1897886796237;793.4604468961104;942.1944237676756;945.4043952310035;949.8717673114111;950.1496160935958;693.4209934704528;706.7208452661222;708.4367927497651;714.6319645382632;715.2061212054615;14838.480653177196;14936.775948360782;14950.925245373703;15004.399824007027;15420.306086226146;12153.513859445611;12156.817647735292;14133.15201087938;14299.356528956221;14339.283035848166;11472;11865.881341186563;11886.762264754656;11897.107716921266;12072.456739446747;3601.6398360164035;3669.5963444021136;3697.334479793636;3711.9443208351895;3738.8878333649764;102705.48647256717;113923.86076139215;114833;120118;120464.39767801105;11200.831987520194;11232.775344493228;11531.76936461266;11583.362915039585;11686.532538698528;18725.719114213298;22457.438564035703;22621;22637.660435093487;22642.320730378116;7719;7737.148913619498;7820.726274580363;8107.594620268963;8186.345092392594;4371.23503386906;4391.187630288407;4448;4502.977485112553;4601.677882548256;3226.6773322668014;3640.2719456108885;3745.382011967995;3754.211615560708;3757.9436308455397;606.1544145916422;659.9901001484982;666.0309250041179;668.909697190873;682.952193346461;490.76933841094626;687.814290141659;698.3470455124374;702.0907924238124;710.9537880037781;9334.439933604006;10330.483475826179;10444.321119127233;10678.893211067945;10687.83968240477;677.1839932880866;719.6114098386918;721.989170162448;722.6784081083972;723.7394537966328;4597.172508948354;5042.697438153723;5050.3939527256225;5062.316587260672;5064.949350506521;101087.49456252818;102313.95372092516;103559.92880142506;104563;104584.47707761412;64093.67953160204;90687;92384.07615923755;94379.05620943703;94576.58135127979;80348;80744.99999999882;80943;82831;83439.16560834435;9693.32146749749;9899.901000989898;9900.851487227554;9906.455144967096;9909.900900990899;52612;53236.201456977404;54046;54142;55318.44681553294;63026.27302952205;65158.348416515226;68008.6599566999;68764.3123568778;69726;13095.803562946754;13233.602991910258;13306.86693133095;13331.66670833237;13591.52429664957;14554.345054472786;14733.852661473677;15120.773188401963;15150.696986059997;15355.692886142439;13569.389377477839;13744.106633068819;13994.860051399355;14307.284635768377;14440;13827.861721382658;13936.4425422986;14126.43494260218;14470.348834302271;14489.855101448851;12689.746205076031;13497.190168589523;13549.729005420033;14028.859711402756;14049.719005620034;10840.295380800539;11219.765825758997;11254.662360129209;11505.079593632321;11633.825492617449;8786.868196976922;11084.224104312621;11356.886431135583;11360.659180224606;11369.829452558384 19:44:38 INFO - PROCESS | 29709 | __end_tp_report 19:44:38 INFO - PROCESS | 29709 | __start_cc_report 19:44:38 INFO - PROCESS | 29709 | _x_x_mozilla_cycle_collect,378 19:44:38 INFO - PROCESS | 29709 | __end_cc_report 19:44:38 INFO - PROCESS | 29709 | __startTimestamp1486525478931__endTimestamp 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | ------- Summary: start ------- 19:44:38 INFO - PROCESS | 29709 | Number of tests: 6 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | [#0] dojo.html Cycles:165 Average:5754.07 Median:6069.76 stddev:666.87 (11.0%) stddev-sans-first:640.86 19:44:38 INFO - PROCESS | 29709 | Values: 3314.4 3322.6 3351.7 3363.5 3370.2 5551.9 5738.7 5798.2 5801.8 5826.2 5747.1 5832.1 5834.1 5846.1 5866.1 5047.5 5276.0 5279.6 5296.0 5321.3 4448.9 4495.3 5309.3 5325.3 5340.9 5136.5 5176.6 5275.5 5329.8 5333.9 5164.7 5182.8 5229.9 5261.7 5328.4 4399.3 5203.5 5211.5 5233.2 5238.7 5587.9 5710.9 5761.3 5768.9 5830.1 6132.2 6139.8 6182.8 6186.1 6188.4 6215.9 6224.6 6231.3 6242.0 6242.6 5776.8 5806.4 5808.8 5829.7 5858.6 6109.7 6182.4 6204.5 6222.4 6251.3 6180.0 6188.2 6218.7 6220.7 6226.5 6240.8 6241.8 6244.7 6249.2 6259.0 6069.8 6149.7 6150.6 6235.7 6241.8 6231.0 6254.6 6258.7 6284.4 6286.0 5027.2 5047.0 5047.7 5052.8 5054.8 4382.3 4435.1 4470.5 4517.5 4521.7 5755.5 5829.4 5872.6 5928.2 5948.5 6249.2 6265.6 6266.8 6267.5 6290.1 4882.3 4895.8 5612.7 5738.7 5804.3 5514.3 5528.2 5532.1 5539.6 5543.6 6371.2 6404.0 6406.3 6407.0 6416.7 5281.3 6136.6 6140.3 6169.4 6187.5 5122.5 6459.1 6461.5 6463.2 6481.1 6164.3 6209.6 6235.3 6241.6 6246.5 6069.7 6201.9 6210.3 6277.1 6287.3 6137.7 6206.3 6209.8 6230.5 6247.4 6153.8 6186.7 6215.7 6237.4 6240.1 5559.0 5781.5 5897.4 6032.9 6111.2 6143.9 6160.0 6164.9 6258.0 6276.7 6098.9 6105.1 6113.3 6119.3 6122.2 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | [#1] ext.html Cycles:180 Average:69186.27 Median:39445.81 stddev:144914.59 (367.4%) stddev-sans-first:145229.17 19:44:38 INFO - PROCESS | 29709 | Values: 434.0 440.6 465.4 478.5 526.4 31398.2 41488.2 41543.0 41617.6 41962.8 42529.6 42532.1 42842.6 42947.1 42960.4 8371.2 8554.9 9128.1 9376.7 9380.6 11084.2 11413.2 11425.4 11558.8 11568.4 9824.4 11455.7 11464.7 11478.3 11495.2 11350.5 11356.5 11364.5 11387.7 11477.0 11268.3 11367.2 11373.7 11374.8 11384.2 40513.8 40847.4 40885.0 40918.2 41051.6 3994.6 4020.3 4066.6 4091.6 4116.2 29338.0 30000.4 30010.5 30904.0 31286.4 3197.0 3285.2 3314.5 3326.3 3396.3 481663.0 483483.0 487911.6 488283.0 488941.1 64724.0 65031.0 65049.0 65189.7 65258.0 68500.3 68681.7 68750.3 68799.7 69113.3 16163.4 16768.2 16781.5 16786.7 16811.3 11704.1 11826.3 12790.5 12980.4 13053.5 14747.8 15447.8 16446.4 17137.4 17587.5 6592.7 7046.2 7061.7 7114.1 7140.8 733.2 866.0 870.3 900.8 916.7 29231.6 29978.3 30246.4 30922.2 31201.5 947.7 1043.2 1119.6 1125.7 1176.7 13659.5 14642.0 17611.6 17613.8 18042.1 595768.0 596673.0 600041.0 602320.0 619009.0 54690.0 64306.7 64477.4 64797.0 65392.0 1430.4 1449.2 1469.2 1473.2 1478.1 29657.7 32059.5 32136.0 32514.0 32866.2 53440.2 54021.0 54033.7 54110.6 54156.7 534885.0 535364.0 537253.0 539589.0 539965.0 36417.3 37188.6 42617.6 43266.4 44204.1 46712.5 47178.8 47656.5 48062.0 48561.5 38732.0 39108.6 39132.6 39399.2 39492.4 32460.2 39527.0 39529.0 40694.4 40785.2 37847.2 38080.8 38456.6 38738.8 38790.4 32074.0 34463.7 34479.7 34708.9 34750.0 24460.9 25140.6 25598.7 25858.7 26298.0 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | [#2] jquery.html Cycles:180 Average:40316.83 Median:25940.98 stddev:124976.34 (481.8%) stddev-sans-first:125290.90 19:44:38 INFO - PROCESS | 29709 | Values: 350.3 380.7 391.8 410.9 421.7 17842.2 20581.5 21294.4 22242.1 22248.3 12046.6 12171.6 12335.6 12462.3 12487.7 5404.6 5614.0 5614.9 5624.4 5631.7 3708.6 4072.2 5493.7 6184.7 6226.9 6270.6 6271.6 6291.8 6297.2 6305.8 6065.4 6196.5 6230.6 6297.9 6323.0 5943.7 6121.5 6135.2 6152.3 6154.4 21469.0 25744.4 25932.9 25949.1 26627.3 2681.9 2694.9 2696.7 2698.7 2734.8 9837.5 10443.6 10447.6 10798.4 10803.5 1876.2 1901.8 1911.8 1924.6 1933.8 123843.0 125829.4 126317.0 128048.4 129951.4 12009.0 12099.9 12150.7 12276.6 12332.4 15913.0 15952.4 15966.7 16017.0 16032.6 7548.4 8770.7 9088.5 9213.2 9281.7 8797.9 8805.3 8811.6 8939.7 8954.9 4835.4 4924.8 4943.4 4978.6 4993.7 1546.0 1701.7 1788.5 2035.7 2082.3 1028.7 1033.9 1065.9 1075.3 1084.9 20874.4 20937.5 20942.3 21000.3 21144.9 1069.9 1081.6 1098.3 1103.0 1107.5 10561.0 11093.3 11098.6 11141.6 11164.8 739086.0 747605.0 748879.0 754663.0 765433.0 110134.0 150002.0 156819.2 158909.0 164851.0 993.6 997.2 1067.3 1077.1 1080.6 19256.4 19435.0 19646.7 19656.1 19804.9 41667.0 59729.7 59905.4 61093.1 61820.0 87686.1 88409.6 88452.0 90063.0 91195.0 5965.8 8394.7 8408.2 8427.0 8673.7 9315.5 9796.9 11239.9 12423.0 13421.7 8171.0 9420.4 10956.4 11025.2 11030.6 8397.6 9383.3 9629.3 10923.0 11315.1 10238.5 10308.6 11278.9 11495.8 11580.2 8166.5 8283.5 8361.7 8469.4 8502.5 8178.1 9920.2 10989.9 11292.5 11329.4 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | [#3] mootools.html Cycles:180 Average:5476.52 Median:5134.73 stddev:2973.16 (57.9%) stddev-sans-first:2964.76 19:44:38 INFO - PROCESS | 29709 | Values: 1278.2 1433.9 1434.1 1458.2 1464.4 7552.9 7784.4 8143.1 8548.8 8595.6 8071.7 8260.9 8342.8 8459.5 8471.2 2306.4 2354.5 2357.3 2360.4 2361.5 2043.0 2078.0 2150.0 2320.7 2369.6 2260.4 2336.7 2338.0 2349.5 2353.4 2311.0 2314.7 2330.2 2334.4 2334.5 2310.2 2330.2 2383.1 2385.1 2395.7 8396.2 8469.2 8492.7 8513.4 8518.6 5000.6 5132.8 5149.2 5150.6 5159.7 3180.0 3312.7 3368.0 3496.2 3540.9 1169.6 1175.7 1200.9 1256.9 1257.1 8666.4 10408.2 10959.9 10983.8 10991.3 4667.7 4721.6 4739.5 4776.2 4787.3 9562.5 9567.4 9590.8 9624.2 9633.8 5204.2 5282.4 5291.0 5293.9 5300.6 4161.9 4609.7 4704.9 4765.3 4808.5 3891.9 3898.6 3957.8 3984.5 3991.8 1012.7 1083.9 1266.6 1305.1 1308.7 859.8 860.0 871.9 883.4 885.2 5201.2 5876.7 5934.1 5992.7 6094.9 999.8 1001.1 1024.3 1029.1 1059.3 3738.7 3976.2 3981.6 4008.7 4026.3 9825.0 10115.2 10119.8 10138.5 10150.5 9460.9 9977.4 10012.9 10076.0 10130.7 7811.5 7884.7 7967.5 7999.0 8019.5 5057.2 5591.9 5643.5 5680.9 5771.5 9092.0 9269.5 9317.7 9340.7 9383.0 9238.3 9304.9 9524.3 9551.2 9559.8 7230.5 7311.0 7328.5 7353.4 7357.3 7708.3 7895.3 7942.8 7980.7 7988.0 7243.3 7259.2 7292.6 7342.2 7396.8 7113.8 7154.3 7159.1 7170.0 7238.9 6457.1 6566.9 6569.3 6584.8 6595.2 4150.0 4437.6 4974.5 5011.5 5131.0 4400.0 4979.5 4994.9 5136.7 5183.9 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | [#4] prototype.html Cycles:180 Average:4566.44 Median:5135.26 stddev:1396.52 (27.2%) stddev-sans-first:1363.25 19:44:38 INFO - PROCESS | 29709 | Values: 301.2 363.3 370.5 371.6 371.7 5242.4 5328.3 5334.6 5408.3 5469.0 4255.7 4330.4 4648.5 5123.5 5460.8 3400.8 4274.6 4286.1 4291.9 4294.3 3727.3 4029.2 4102.0 4106.4 4166.0 4067.9 4113.7 4115.2 4120.8 4141.5 3743.8 4119.6 4120.7 4138.4 4165.6 3122.4 3245.4 3327.7 3489.1 3599.7 4811.3 4937.1 5283.2 5300.3 5321.5 4682.1 4704.0 4722.6 4724.6 4730.7 5093.6 5132.0 5138.5 5635.0 5748.9 3938.7 3949.5 3961.3 3964.3 3972.6 5440.0 5447.9 6078.3 6088.3 6170.2 3784.6 3909.8 3932.0 3969.7 3973.3 3709.2 3996.9 4024.6 4037.4 4046.9 4688.9 4699.7 4709.8 4718.4 4778.8 4765.3 5359.4 5680.5 5795.0 5900.6 1242.9 1253.5 1273.1 1305.4 1308.5 832.9 850.2 867.8 881.5 886.4 4648.6 4695.2 5123.7 5153.3 5217.4 5364.8 5529.5 5710.7 5740.6 5772.9 4794.7 4831.7 5206.5 5208.6 5216.7 2795.7 2928.1 2976.5 2991.0 3001.3 4965.8 5122.7 5843.9 5861.6 5900.9 5415.1 5552.6 5792.2 5826.2 5863.7 5292.3 5671.4 5728.5 5861.7 5864.7 5095.2 5213.6 5340.5 5637.2 5732.2 5609.2 5647.7 5656.2 5721.6 5767.4 4976.7 5487.7 5538.6 5769.3 5883.2 3246.6 3329.7 3384.8 3621.1 3821.8 5544.3 5594.7 5632.5 5665.5 5672.7 4565.7 5624.3 5802.2 5822.4 5840.1 5744.7 5781.7 5782.6 5792.8 5794.2 5304.8 5326.8 5567.1 5636.0 5674.5 5399.8 5669.0 5823.8 5835.5 5916.9 4574.2 4991.9 5378.5 5648.7 5751.3 19:44:38 INFO - PROCESS | 29709 | 19:44:38 INFO - PROCESS | 29709 | [#5] yui.html Cycles:180 Average:20892.68 Median:3749.80 stddev:30351.26 (809.4%) stddev-sans-first:30398.36 19:44:38 INFO - PROCESS | 29709 | Values: 652.5 731.2 733.2 735.8 763.2 12953.6 13426.7 14530.6 15170.8 15572.8 12737.7 12836.3 12924.7 12964.0 13291.1 875.7 884.4 889.0 890.0 891.6 703.8 821.3 886.6 900.3 902.2 942.9 947.9 950.9 951.8 953.2 793.5 942.2 945.4 949.9 950.1 693.4 706.7 708.4 714.6 715.2 14838.5 14936.8 14950.9 15004.4 15420.3 12153.5 12156.8 14133.2 14299.4 14339.3 11472.0 11865.9 11886.8 11897.1 12072.5 3601.6 3669.6 3697.3 3711.9 3738.9 102705.5 113923.9 114833.0 120118.0 120464.4 11200.8 11232.8 11531.8 11583.4 11686.5 18725.7 22457.4 22621.0 22637.7 22642.3 7719.0 7737.1 7820.7 8107.6 8186.3 4371.2 4391.2 4448.0 4503.0 4601.7 3226.7 3640.3 3745.4 3754.2 3757.9 606.2 660.0 666.0 668.9 683.0 490.8 687.8 698.3 702.1 711.0 9334.4 10330.5 10444.3 10678.9 10687.8 677.2 719.6 722.0 722.7 723.7 4597.2 5042.7 5050.4 5062.3 5064.9 101087.5 102314.0 103559.9 104563.0 104584.5 64093.7 90687.0 92384.1 94379.1 94576.6 80348.0 80745.0 80943.0 82831.0 83439.2 9693.3 9899.9 9900.9 9906.5 9909.9 52612.0 53236.2 54046.0 54142.0 55318.4 63026.3 65158.3 68008.7 68764.3 69726.0 13095.8 13233.6 13306.9 13331.7 13591.5 14554.3 14733.9 15120.8 15150.7 15355.7 13569.4 13744.1 13994.9 14307.3 14440.0 13827.9 13936.4 14126.4 14470.3 14489.9 12689.7 13497.2 13549.7 14028.9 14049.7 10840.3 11219.8 11254.7 11505.1 11633.8 8786.9 11084.2 11356.9 11360.7 11369.8 19:44:38 INFO - PROCESS | 29709 | -------- Summary: end -------- 19:44:38 INFO - PROCESS | 29709 | 19:44:39 INFO - TEST-INFO | 29709: exit 0 19:44:39 INFO - TEST-OK | dromaeo_css | took 1114885ms 19:44:39 INFO - TEST-START | kraken 19:44:39 INFO - operating with platform_type : mac_ 19:44:39 INFO - Initialising browser for kraken test... 19:44:39 INFO - TEST-INFO | started process 29717 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpQUdmzE/profile http://localhost:49293/getInfo.html) 19:44:42 INFO - PROCESS | 29717 | 2017-02-07 19:44:42.252 plugin-container[29718:275511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 19:44:42 INFO - PROCESS | 29717 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:44:42 INFO - PROCESS | 29717 | 2017-02-07 19:44:42.255 plugin-container[29718:275511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 19:44:42 INFO - PROCESS | 29717 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:44:42 INFO - PROCESS | 29717 | 2017-02-07 19:44:42.255 plugin-container[29718:275511] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:44:42 INFO - PROCESS | 29717 | __metrics Screen width/height:1600/1200 19:44:42 INFO - PROCESS | 29717 | colorDepth:24 19:44:42 INFO - PROCESS | 29717 | Browser inner width/height: 1024/689 19:44:42 INFO - PROCESS | 29717 | __metrics 19:44:42 ERROR - PROCESS | 29717 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 19:44:42 INFO - PROCESS | 29717 | 1486525482445 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/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpQUdmzE/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpQUdmzE/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpQUdmzE/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpQUdmzE/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:44:43 INFO - TEST-INFO | 29717: exit 0 19:44:43 INFO - Browser initialized. 19:44:43 INFO - Running cycle 1/1 for kraken test... 19:44:43 INFO - TEST-INFO | started process 29719 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpQUdmzE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:45 INFO - PROCESS | 29719 | 2017-02-07 19:44:45.695 plugin-container[29720:275641] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 19:44:45 INFO - PROCESS | 29719 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:44:45 INFO - PROCESS | 29719 | 2017-02-07 19:44:45.696 plugin-container[29720:275641] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 19:44:45 INFO - PROCESS | 29719 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:44:45 INFO - PROCESS | 29719 | 2017-02-07 19:44:45.696 plugin-container[29720:275641] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:44:55 INFO - PROCESS | 29719 | RSS: Main: 218578944 19:44:55 INFO - PROCESS | 29719 | 19:44:58 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-beat-detection) 19:44:59 INFO - PROCESS | 29719 | RSS: Main: 233050112 19:44:59 INFO - PROCESS | 29719 | 19:45:02 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-dft) 19:45:02 INFO - PROCESS | 29719 | RSS: Main: 242176000 19:45:02 INFO - PROCESS | 29719 | 19:45:06 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-fft) 19:45:07 INFO - PROCESS | 29719 | RSS: Main: 243081216 19:45:07 INFO - PROCESS | 29719 | 19:45:09 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-oscillator) 19:45:09 INFO - PROCESS | 29719 | RSS: Main: 245633024 19:45:09 INFO - PROCESS | 29719 | 19:45:11 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:45:12 INFO - PROCESS | 29719 | RSS: Main: 245968896 19:45:12 INFO - PROCESS | 29719 | 19:45:15 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-darkroom) 19:45:16 INFO - PROCESS | 29719 | RSS: Main: 250630144 19:45:16 INFO - PROCESS | 29719 | 19:45:18 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-desaturate) 19:45:19 INFO - PROCESS | 29719 | RSS: Main: 249413632 19:45:19 INFO - PROCESS | 29719 | 19:45:22 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49293/tests/kraken/driver.html?testName=json-parse-financial) 19:45:23 INFO - PROCESS | 29719 | RSS: Main: 249405440 19:45:23 INFO - PROCESS | 29719 | 19:45:24 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:45:25 INFO - PROCESS | 29719 | RSS: Main: 248762368 19:45:25 INFO - PROCESS | 29719 | 19:45:27 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:45:28 INFO - PROCESS | 29719 | RSS: Main: 248786944 19:45:28 INFO - PROCESS | 29719 | 19:45:30 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:45:31 INFO - PROCESS | 29719 | RSS: Main: 249106432 19:45:31 INFO - PROCESS | 29719 | 19:45:34 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:45:34 INFO - PROCESS | 29719 | RSS: Main: 249425920 19:45:34 INFO - PROCESS | 29719 | 19:45:37 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:45:38 INFO - PROCESS | 29719 | RSS: Main: 249241600 19:45:38 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49293/tests/kraken/driver.html?testName=ai-astar) 19:45:40 INFO - PROCESS | 29719 | RSS: Main: 250896384 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | __start_tp_report 19:45:40 INFO - PROCESS | 29719 | _x_x_mozilla_page_load 19:45:40 INFO - PROCESS | 29719 | _x_x_mozilla_page_load_details 19:45:40 INFO - PROCESS | 29719 | |i|pagename|runs| 19:45:40 INFO - PROCESS | 29719 | |0;ai-astar;135;171;155;171;147;116;166;177;136;117 19:45:40 INFO - PROCESS | 29719 | |1;audio-beat-detection;153;139;109;185;114;110;140;115;134;109 19:45:40 INFO - PROCESS | 29719 | |2;audio-dft;192;206;257;233;227;282;189;272;278;200 19:45:40 INFO - PROCESS | 29719 | |3;audio-fft;76;86;82;95;53;76;83;85;96;53 19:45:40 INFO - PROCESS | 29719 | |4;audio-oscillator;87;70;84;73;71;72;80;69;71;81 19:45:40 INFO - PROCESS | 29719 | |5;imaging-gaussian-blur;88;87;96;117;89;78;135;131;88;86 19:45:40 INFO - PROCESS | 29719 | |6;imaging-darkroom;95;96;95;95;96;96;96;95;96;96 19:45:40 INFO - PROCESS | 29719 | |7;imaging-desaturate;91;131;92;142;145;93;142;142;111;92 19:45:40 INFO - PROCESS | 29719 | |8;json-parse-financial;58;60;60;62;64;62;63;62;63;64 19:45:40 INFO - PROCESS | 29719 | |9;json-stringify-tinderbox;69;78;71;88;118;111;101;75;70;73 19:45:40 INFO - PROCESS | 29719 | |10;stanford-crypto-aes;84;85;83;84;84;84;85;86;88;82 19:45:40 INFO - PROCESS | 29719 | |11;stanford-crypto-ccm;143;138;146;143;161;154;156;143;193;162 19:45:40 INFO - PROCESS | 29719 | |12;stanford-crypto-pbkdf2;198;188;169;169;184;222;161;220;221;167 19:45:40 INFO - PROCESS | 29719 | |13;stanford-crypto-sha256-iterative;68;69;67;85;66;66;67;66;65;81 19:45:40 INFO - PROCESS | 29719 | __end_tp_report 19:45:40 INFO - PROCESS | 29719 | __start_cc_report 19:45:40 INFO - PROCESS | 29719 | _x_x_mozilla_cycle_collect,936 19:45:40 INFO - PROCESS | 29719 | __end_cc_report 19:45:40 INFO - PROCESS | 29719 | __startTimestamp1486525540571__endTimestamp 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | ------- Summary: start ------- 19:45:40 INFO - PROCESS | 29719 | Number of tests: 14 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#0] ai-astar Cycles:10 Average:149.10 Median:160.50 stddev:22.51 (14.0%) stddev-sans-first:23.29 19:45:40 INFO - PROCESS | 29719 | Values: 135.0 171.0 155.0 171.0 147.0 116.0 166.0 177.0 136.0 117.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:136.50 stddev:24.74 (18.1%) stddev-sans-first:24.90 19:45:40 INFO - PROCESS | 29719 | Values: 153.0 139.0 109.0 185.0 114.0 110.0 140.0 115.0 134.0 109.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#2] audio-dft Cycles:10 Average:233.60 Median:245.00 stddev:36.50 (14.9%) stddev-sans-first:35.47 19:45:40 INFO - PROCESS | 29719 | Values: 192.0 206.0 257.0 233.0 227.0 282.0 189.0 272.0 278.0 200.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#3] audio-fft Cycles:10 Average:78.50 Median:84.00 stddev:14.99 (17.8%) stddev-sans-first:15.87 19:45:40 INFO - PROCESS | 29719 | Values: 76.0 86.0 82.0 95.0 53.0 76.0 83.0 85.0 96.0 53.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:76.50 stddev:6.55 (8.6%) stddev-sans-first:5.55 19:45:40 INFO - PROCESS | 29719 | Values: 87.0 70.0 84.0 73.0 71.0 72.0 80.0 69.0 71.0 81.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:87.50 stddev:20.40 (23.3%) stddev-sans-first:21.21 19:45:40 INFO - PROCESS | 29719 | Values: 88.0 87.0 96.0 117.0 89.0 78.0 135.0 131.0 88.0 86.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:45:40 INFO - PROCESS | 29719 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#7] imaging-desaturate Cycles:10 Average:118.10 Median:118.00 stddev:24.45 (20.7%) stddev-sans-first:23.89 19:45:40 INFO - PROCESS | 29719 | Values: 91.0 131.0 92.0 142.0 145.0 93.0 142.0 142.0 111.0 92.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.50 stddev:1.93 (3.1%) stddev-sans-first:1.48 19:45:40 INFO - PROCESS | 29719 | Values: 58.0 60.0 60.0 62.0 64.0 62.0 63.0 62.0 63.0 64.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#9] json-stringify-tinderbox Cycles:10 Average:85.40 Median:72.00 stddev:18.25 (25.4%) stddev-sans-first:18.37 19:45:40 INFO - PROCESS | 29719 | Values: 69.0 78.0 71.0 88.0 118.0 111.0 101.0 75.0 70.0 73.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:1.65 (2.0%) stddev-sans-first:1.74 19:45:40 INFO - PROCESS | 29719 | Values: 84.0 85.0 83.0 84.0 84.0 84.0 85.0 86.0 88.0 82.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:155.00 stddev:16.06 (10.4%) stddev-sans-first:16.54 19:45:40 INFO - PROCESS | 29719 | Values: 143.0 138.0 146.0 143.0 161.0 154.0 156.0 143.0 193.0 162.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.90 Median:193.00 stddev:24.13 (12.5%) stddev-sans-first:25.42 19:45:40 INFO - PROCESS | 29719 | Values: 198.0 188.0 169.0 169.0 184.0 222.0 161.0 220.0 221.0 167.0 19:45:40 INFO - PROCESS | 29719 | 19:45:40 INFO - PROCESS | 29719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:67.50 stddev:7.01 (10.4%) stddev-sans-first:7.40 19:45:40 INFO - PROCESS | 29719 | Values: 68.0 69.0 67.0 85.0 66.0 66.0 67.0 66.0 65.0 81.0 19:45:40 INFO - PROCESS | 29719 | -------- Summary: end -------- 19:45:40 INFO - PROCESS | 29719 | 19:45:41 INFO - TEST-INFO | 29719: exit 0 19:45:41 INFO - TEST-OK | kraken | took 61918ms 19:45:41 INFO - SUITE-END | took 1176s 19:45:41 INFO - Completed test suite (00:19:37) 19:45:41 INFO - javascript benchmark 19:45:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7378.5887223878235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.38683843489, 3322.634510203876, 3351.7318614510837, 3363.5459213006243, 3370.1574606348413, 5551.916721249175, 5738.7417566209515, 5798.217240672513, 5801.796937107202, 5826.21346118275, 5747.051736463489, 5832.125181222818, 5834.095715164156, 5846.093855452401, 5866.149408335799, 5047.47001564836, 5275.997560463509, 5279.63042587019, 5295.973520132394, 5321.255024296602, 4448.888777780549, 4495.325701144821, 5309.283246761695, 5325.334333208349, 5340.946590534084, 5136.4606716295, 5176.637635365526, 5275.525202731754, 5329.840104796862, 5333.919991200135, 5164.715940623264, 5182.818601348972, 5229.947700523022, 5261.710605916673, 5328.387235467893, 4399.318105693623, 5203.531682148587, 5211.5049070338255, 5233.241180028913, 5238.685678859242, 5587.944120558783, 5710.942890571083, 5761.251037365158, 5768.942310576883, 5830.096335068071, 6132.233470816148, 6139.829471381233, 6182.84542886427, 6186.072089186658, 6188.412100850412, 6215.906761398583, 6224.564280500367, 6231.283402408736, 6242.0, 6242.5942313749465, 5776.815752770672, 5806.44838740319, 5808.8257352279925, 5829.708514574254, 5858.619189752652, 6109.7387008107025, 6182.412670796267, 6204.472619827366, 6222.377762223832, 6251.3123556408755, 6180.0, 6188.226471691039, 6218.657973811393, 6220.688965551704, 6226.470749986302, 6240.781572645026, 6241.750329986749, 6244.687765611701, 6249.187605611241, 6259.0, 6069.757209711651, 6149.723262453201, 6150.630962142286, 6235.688215589294, 6241.78153764616, 6231.0, 6254.593451425642, 6258.718357673915, 6284.4344009039405, 6286.0, 5027.2207807789855, 5047.041062198171, 5047.671901326402, 5052.797888084436, 5054.82308119214, 4382.255016647177, 4435.112977404532, 4470.530594287553, 4517.525659805673, 4521.706089104197, 5755.539556835443, 5829.387914269026, 5872.559558033079, 5928.170056192136, 5948.494377977834, 6249.187605611332, 6265.561410701298, 6266.811995640138, 6267.467265282411, 6290.119383286344, 4882.340883980688, 4895.8041678332465, 5612.719364031782, 5738.741756620879, 5804.332501762267, 5514.255575497336, 5528.170774383874, 5532.059549876531, 5539.612227144061, 5543.6396634218645, 6371.235451745728, 6404.0, 6406.295307516077, 6407.038944158414, 6416.743330266737, 5281.313429254173, 6136.641621527207, 6140.28953073628, 6169.413905678954, 6187.504999599932, 5122.462141475092, 6459.128017717548, 6461.450776683847, 6463.192100987377, 6481.125048118633, 6164.31889890938, 6209.565330427007, 6235.3452887446165, 6241.563090583615, 6246.500279977682, 6069.726862291119, 6201.906971395523, 6210.285817131088, 6277.058441233851, 6287.339829318039, 6137.7447333336595, 6206.286277078194, 6209.751609935552, 6230.470410015199, 6247.406496382836, 6153.84615384619, 6186.690665466619, 6215.65813880241, 6237.376262373727, 6240.126382306572, 5558.972205138948, 5781.537477001746, 5897.410258974069, 6032.8793424132145, 6111.236095488064, 6143.941779503737, 6160.0, 6164.907526387197, 6257.968710156602, 6276.744651069896, 6098.9390106100145, 6105.053716673922, 6113.266408031065, 6119.265688117454, 6122.204113465221], "value": 5711.2458737525885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.03860449105224, 440.5924519819167, 465.41357889059776, 478.4808482796166, 526.3972751199879, 31398.215044623867, 41488.170236595324, 41542.961425964364, 41617.58382416179, 41962.790186049024, 42529.57470425295, 42532.14935701292, 42842.57157428425, 42947.14105717884, 42960.35559466611, 8371.246587807096, 8554.871676924851, 9128.087191280885, 9376.718698439023, 9380.624775008991, 11084.224104312701, 11413.201075924688, 11425.42872856358, 11558.826617600742, 11568.363739994296, 9824.410535367864, 11455.656330310063, 11464.71338216543, 11478.253913495597, 11495.19533632646, 11350.545978160864, 11356.48895799691, 11364.545418183263, 11387.715307117305, 11477.024452921512, 11268.323900565993, 11367.204295699305, 11373.715657108556, 11374.772504549945, 11384.203105782599, 40513.79743101266, 40847.38728919069, 40885.0, 40918.1816363674, 41051.589484105076, 3994.560598334181, 4020.2562525932794, 4066.5526792053147, 4091.6317531422314, 4116.197341518405, 29337.973170939127, 30000.399992000257, 30010.549841752392, 30904.0, 31286.37427251465, 3197.0, 3285.162283617662, 3314.5359649649067, 3326.268220991378, 3396.252824378633, 481663.0, 483483.0, 487911.56044219906, 488283.0, 488941.1082390467, 64724.0, 65031.024534632015, 65049.0, 65189.69620607561, 65258.0, 68500.3149968494, 68681.65659171672, 68750.3124968754, 68799.65600171968, 69113.30886691068, 16163.353465861233, 16768.245428955724, 16781.496555103367, 16786.74819877703, 16811.327546898232, 11704.063674905987, 11826.290422574673, 12790.488380464863, 12980.415881285366, 13053.543125990545, 14747.820174386023, 15447.845521544641, 16446.424375146813, 17137.400190993256, 17587.47237582849, 6592.703328350236, 7046.154461464657, 7061.682224299919, 7114.146302443636, 7140.821479462951, 733.1524558113631, 865.9783505412415, 870.2586851417957, 900.819836032796, 916.7295647783919, 29231.56152657712, 29978.250543736143, 30246.395072098436, 30922.226944326572, 31201.531977020364, 947.7251597036782, 1043.2488608202082, 1119.6081371519904, 1125.7410795516914, 1176.6940595445246, 13659.453621855213, 14642.04826686262, 17611.647767044586, 17613.844978317677, 18042.09789510519, 595768.0, 596673.0, 600041.0, 602320.0, 619009.0, 54690.0, 64306.678466607365, 64477.355226448075, 64797.0, 65392.019119713244, 1430.4349781836117, 1449.1956963884934, 1469.2286549561566, 1473.1676602719429, 1478.113132120719, 29657.70342296636, 32059.519107213877, 32136.0, 32514.0, 32866.17834554155, 53440.198397024855, 54021.0, 54033.72983135059, 54110.64723381947, 54156.72921635367, 534885.0, 535364.0, 537253.0, 539589.0, 539965.0, 36417.27165456623, 37188.628113718514, 42617.5738242626, 43266.35100473558, 44204.11591768211, 46712.53287467082, 47178.76410617925, 47656.52343476521, 48062.0, 48561.5143848557, 38732.0, 39108.608913910495, 39132.60867391404, 39399.21201575895, 39492.40761388639, 32460.188495287806, 39527.0, 39529.0, 40694.38958415685, 40785.1842963145, 37847.24305513819, 38080.80959595184, 38456.615433845305, 38738.837834865, 38790.41814372843, 32074.0, 34463.65536344604, 34479.65520344764, 34708.91746495218, 34750.0, 24460.87769561141, 25140.62289065629, 25598.744012560383, 25858.741412586387, 26298.0], "value": 20681.574647515346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.33436470705664, 380.7144641518861, 391.82563759127163, 410.91165399439114, 421.65845665011324, 17842.19710113045, 20581.485462863435, 21294.36116916495, 22242.110315587397, 22248.332550023504, 12046.638600841967, 12171.57399491018, 12335.568255111073, 12462.314572698499, 12487.68780780481, 5404.6486978346475, 5614.045612245928, 5614.9157762633595, 5624.3531993820625, 5631.690257035862, 3708.592054873962, 4072.2059198456313, 5493.670379777206, 6184.659843708594, 6226.906596401058, 6270.561060725751, 6271.592346497463, 6291.842703932415, 6297.244330680325, 6305.8108256752375, 6065.363136870631, 6196.535259855506, 6230.59501132425, 6297.929352010169, 6322.968385158091, 5943.692387674748, 6121.540884433685, 6135.171751813493, 6152.2924863640355, 6154.353792851775, 21469.0, 25744.356391090187, 25932.87033564839, 25949.091781787734, 26627.334316642045, 2681.8927242910454, 2694.932626684329, 2696.703362630109, 2698.743619356158, 2734.753872151496, 9837.458939758311, 10443.582256709722, 10447.634332798392, 10798.406087665175, 10803.459827008697, 1876.2495001999173, 1901.7717873855088, 1911.7801452832964, 1924.6343194792944, 1933.7679478462535, 123843.0, 125829.37085314606, 126317.0, 128048.35975820155, 129951.35024325007, 12009.039276857831, 12099.879001209874, 12150.696232594255, 12276.631701048982, 12332.445039973223, 15913.0, 15952.441664541686, 15966.680666386606, 16017.0, 16032.599185020468, 7548.358389536841, 8770.736877893672, 9088.545572721338, 9213.170814626716, 9281.675141370155, 8797.868031979526, 8805.339599530062, 8811.603477843384, 8939.73180804577, 8954.86567701485, 4835.443923948791, 4924.8030078797165, 4943.382077240345, 4978.6017118630425, 4993.725345105981, 1545.961350966235, 1701.651161511887, 1788.4902802701167, 2035.6844689073218, 2082.3336532309518, 1028.7273872423814, 1033.927625066238, 1065.9374111095055, 1075.3332933581073, 1084.8969347911936, 20874.37376878696, 20937.476563086046, 20942.267020654508, 21000.264990725253, 21144.894275528524, 1069.9411532365639, 1081.5723245316265, 1098.3464838421128, 1103.0293341859112, 1107.545906178463, 10561.0, 11093.33439993603, 11098.61154859576, 11141.610043648434, 11164.776704465865, 739086.0, 747605.0, 748879.0, 754663.0, 765433.0, 110134.0, 150002.0, 156819.21590391974, 158909.0, 164850.9999999976, 993.6273897288517, 997.1972562087589, 1067.2689207892463, 1077.1490522487304, 1080.5515710979855, 19256.422307330802, 19435.028248587798, 19646.705299420806, 19656.11547480338, 19804.90097549503, 41666.95832604209, 59729.701351492964, 59905.40094598998, 61093.08360374687, 61820.0, 87686.12313877034, 88409.55795220983, 88452.0, 90063.0, 91195.0, 5965.761369545169, 8394.664213431395, 8408.201220884006, 8427.0, 8673.739787806377, 9315.534223288943, 9796.9020309796, 11239.932206440375, 12423.0, 13421.731565368442, 8171.0, 9420.38767480139, 10956.397398142859, 11025.17311201647, 11030.613928512463, 8397.580120994047, 9383.343165978316, 9629.32594718363, 10923.0, 11315.094792416423, 10238.488075596339, 10308.639197628347, 11278.887211127783, 11495.827562586735, 11580.247283926517, 8166.469179503313, 8283.450572382964, 8361.749147525585, 8469.407141500036, 8502.532360720219, 8178.141295163922, 9920.206383489447, 10989.890101098887, 11292.548298068314, 11329.433528323716], "value": 9765.876843203025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.2138984524518, 1433.8852891768654, 1434.146682723779, 1458.197991104892, 1464.377639503211, 7552.90482879982, 7784.377249820015, 8143.063547692017, 8548.829023419528, 8595.613197406115, 8071.717489887855, 8260.91739082609, 8342.791430214247, 8459.53472559009, 8471.152884711526, 2306.3657494189106, 2354.458474550846, 2357.292812156355, 2360.36270207044, 2361.4804742956608, 2043.0397713074906, 2077.9584408311825, 2150.032485381577, 2320.7331156917003, 2369.609014512603, 2260.4235919840416, 2336.684547586071, 2337.9883100584557, 2349.4713689419827, 2353.4234112642425, 2311.04091801902, 2314.652802079693, 2330.1727886600183, 2334.439734463725, 2334.5447637710654, 2310.1798861404127, 2330.1611419888827, 2383.1420688552107, 2385.105585405473, 2395.748446413119, 8396.244338009546, 8469.19542643454, 8492.66029358825, 8513.404061715682, 8518.57407129641, 5000.574951129159, 5132.769025393829, 5149.227615857614, 5150.587952963754, 5159.664621799571, 3180.0, 3312.685294896981, 3368.0, 3496.248306614065, 3540.946885796715, 1169.561414469574, 1175.747214348919, 1200.9159358844884, 1256.8805963433458, 1257.1262972234301, 8666.39335246533, 10408.219383546264, 10959.945200273947, 10983.780324393547, 10991.285566438235, 4667.743274119888, 4721.645876559203, 4739.478657347689, 4776.2119250324, 4787.257975013878, 9562.474063926551, 9567.37812042215, 9590.808183836285, 9624.181944534654, 9633.807323853624, 5204.167333226741, 5282.418933917266, 5291.0, 5293.920591191135, 5300.628955973122, 4161.854335098257, 4609.723416595015, 4704.929426058612, 4765.285207218945, 4808.519148085164, 3891.9416208756893, 3898.590647981978, 3957.8021098944937, 3984.541777695544, 3991.840326386912, 1012.6658202793061, 1083.8890137608855, 1266.5946896992873, 1305.1190446448609, 1308.653206900172, 859.8194379180317, 859.9828003439897, 871.9476831390136, 883.4478450968145, 885.1590988560893, 5201.1678131498775, 5876.676782776988, 5934.13954976526, 5992.730327135289, 6094.908576371358, 999.7750506136207, 1001.114014097529, 1024.3393011507535, 1029.0584115534352, 1059.3114475590928, 3738.663520283133, 3976.1650053489093, 3981.6217459341315, 4008.679305655599, 4026.295398305285, 9824.95087524572, 10115.190784737204, 10119.797604047877, 10138.543765530421, 10150.543225554868, 9460.8580871287, 9977.351472154287, 10012.899871001197, 10075.992400760011, 10130.746731331628, 7811.453198276066, 7884.72403465876, 7967.521948683214, 7999.0, 8019.518828870287, 5057.216131499624, 5591.916121258103, 5643.463870932255, 5680.857978550569, 5771.451712087345, 9091.999880013062, 9269.53652317368, 9317.673881414117, 9340.71977840666, 9383.01478344764, 9238.260939124719, 9304.860427093463, 9524.285678574273, 9551.235901128031, 9559.761005974906, 7230.45771567124, 7311.049563556916, 7328.450366222662, 7353.411727061929, 7357.301056399633, 7708.3062524370835, 7895.328897043815, 7942.801429964297, 7980.720674776355, 7988.041435027834, 7243.275672432715, 7259.20148783644, 7292.598907060163, 7342.229065947999, 7396.778096657109, 7113.75101871432, 7154.284571542804, 7159.069320988238, 7170.0, 7238.877973914052, 6457.063725759833, 6566.9014964774615, 6569.310222426577, 6584.814733348044, 6595.241547222131, 4149.97925010373, 4437.5784300491405, 4974.477679843564, 5011.473795251592, 5131.0, 4400.0, 4979.516845842454, 4994.850154495371, 5136.691798492103, 5183.948160518497], "value": 4452.1451876181845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2483852787296, 363.27345309381235, 370.52387681828856, 371.62465909431484, 371.72492355656806, 5242.397124330703, 5328.280682107914, 5334.5732341412695, 5408.296921400222, 5468.988237176125, 4255.680823938209, 4330.39374487572, 4648.511906249846, 5123.462036486171, 5460.754266058027, 3400.7927185848916, 4274.551172126929, 4286.099919017002, 4291.892702682427, 4294.334378171388, 3727.3104475671953, 4029.234445455354, 4101.9589804102025, 4106.38404239365, 4165.958340416602, 4067.9186416271655, 4113.732607380525, 4115.218108559379, 4120.846163074344, 4141.482314710661, 3743.8315275812383, 4119.588041195856, 4120.711550191473, 4138.399932009872, 4165.645920096796, 3122.3911337289237, 3245.4259684053213, 3327.6505966873374, 3489.1333136771705, 3599.748017638766, 4811.254255590389, 4937.111319962405, 5283.207518872162, 5300.330395925271, 5321.467853214686, 4682.08699303636, 4703.976480117578, 4722.622190224808, 4724.5984091352275, 4730.668853180278, 5093.567046801027, 5131.974340128313, 5138.537531622172, 5635.0138725723245, 5748.856278593027, 3938.704597155196, 3949.526056873165, 3961.3265744823448, 3964.32606456903, 3972.642462178389, 5440.0, 5447.918281225824, 6078.300995385499, 6088.299845517778, 6170.210638914709, 3784.5807822066727, 3909.8465952544066, 3931.9803400983383, 3969.7419667721506, 3973.3443981743267, 3709.1995543364587, 3996.860894645012, 4024.6377825995214, 4037.354023356249, 4046.8785936421955, 4688.929666055012, 4699.718016918996, 4709.811607535728, 4718.386609740712, 4778.784954677048, 4765.26138448541, 5359.356877174686, 5680.488756011979, 5795.0, 5900.557458190653, 1242.9062425066065, 1253.473541112735, 1273.0961017677553, 1305.3943649311211, 1308.5093090091216, 832.8584140696096, 850.2135524639807, 867.7917299847991, 881.4799268431656, 886.3573908915985, 4648.604868586141, 4695.248760198352, 5123.718195499208, 5153.320273457781, 5217.373915130132, 5364.8122315718765, 5529.474699903502, 5710.7430165642645, 5740.56945729072, 5772.884542309131, 4794.657495901153, 4831.661783675179, 5206.505381988705, 5208.609354298367, 5216.686998780086, 2795.6784969728333, 2928.092291389676, 2976.4968690811, 2991.012965721307, 3001.2796928737384, 4965.751712414365, 5122.667026643257, 5843.883122337529, 5861.6189947653265, 5900.940990590125, 5415.106507426231, 5552.639078459968, 5792.190787468075, 5826.213461182686, 5863.70681465925, 5292.338457692866, 5671.427000989351, 5728.455796699307, 5861.681121747572, 5864.654138344611, 5095.24214146119, 5213.60897932649, 5340.519353258225, 5637.238972738792, 5732.16883551891, 5609.205054382722, 5647.745851436613, 5656.151577263443, 5721.599488035964, 5767.423257674199, 4976.701397915992, 5487.670739755627, 5538.584606154635, 5769.336526299529, 5883.235179426647, 3246.626637936573, 3329.716974057232, 3384.830758462116, 3621.092017203868, 3821.8089095544556, 5544.3346798384455, 5594.69229192382, 5632.493075623213, 5665.518430933417, 5672.681481333466, 4565.726056436624, 5624.312706188045, 5802.158686990447, 5822.446867547576, 5840.123981402654, 5744.655320680772, 5781.710914454345, 5782.554361409648, 5792.756056608313, 5794.159846822103, 5304.814331498379, 5326.816005437752, 5567.137093750475, 5635.971820140873, 5674.460926212003, 5399.78400863961, 5669.0, 5823.79616713413, 5835.54111472132, 5916.911246331222, 4574.222382194968, 4991.9001619966675, 5378.542823859859, 5648.745806438802, 5751.309842818889], "value": 4128.026948465364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.4845372155996, 731.2486941987606, 733.189825243106, 735.7755884455239, 763.1795819494042, 12953.575106738263, 13426.731465370687, 14530.636734081654, 15170.84829151708, 15572.844271557282, 12737.745245095093, 12836.294003829786, 12924.676883077904, 12964.027697922646, 13291.136076155068, 875.6803766625184, 884.3941899798626, 889.0442774017924, 890.0165317324361, 891.6121487153076, 703.7747920665389, 821.3183058061824, 886.6364790435922, 900.3022657440471, 902.1519771414881, 942.9434233945985, 947.8578213267996, 950.857371394293, 951.7810903492201, 953.1897886796237, 793.4604468961104, 942.1944237676756, 945.4043952310035, 949.8717673114111, 950.1496160935958, 693.4209934704528, 706.7208452661222, 708.4367927497651, 714.6319645382632, 715.2061212054615, 14838.480653177196, 14936.775948360782, 14950.925245373703, 15004.399824007027, 15420.306086226146, 12153.513859445611, 12156.817647735292, 14133.15201087938, 14299.356528956221, 14339.283035848166, 11472.0, 11865.881341186563, 11886.762264754656, 11897.107716921266, 12072.456739446747, 3601.6398360164035, 3669.5963444021136, 3697.334479793636, 3711.9443208351895, 3738.8878333649764, 102705.48647256717, 113923.86076139215, 114833.0, 120118.0, 120464.39767801105, 11200.831987520194, 11232.775344493228, 11531.76936461266, 11583.362915039585, 11686.532538698528, 18725.719114213298, 22457.438564035703, 22621.0, 22637.660435093487, 22642.320730378116, 7719.0, 7737.148913619498, 7820.726274580363, 8107.594620268963, 8186.345092392594, 4371.23503386906, 4391.187630288407, 4448.0, 4502.977485112553, 4601.677882548256, 3226.6773322668014, 3640.2719456108885, 3745.382011967995, 3754.211615560708, 3757.9436308455397, 606.1544145916422, 659.9901001484982, 666.0309250041179, 668.909697190873, 682.952193346461, 490.76933841094626, 687.814290141659, 698.3470455124374, 702.0907924238124, 710.9537880037781, 9334.439933604006, 10330.483475826179, 10444.321119127233, 10678.893211067945, 10687.83968240477, 677.1839932880866, 719.6114098386918, 721.989170162448, 722.6784081083972, 723.7394537966328, 4597.172508948354, 5042.697438153723, 5050.3939527256225, 5062.316587260672, 5064.949350506521, 101087.49456252818, 102313.95372092516, 103559.92880142506, 104563.0, 104584.47707761412, 64093.67953160204, 90687.0, 92384.07615923755, 94379.05620943703, 94576.58135127979, 80348.0, 80744.99999999882, 80943.0, 82831.0, 83439.16560834435, 9693.32146749749, 9899.901000989898, 9900.851487227554, 9906.455144967096, 9909.900900990899, 52612.0, 53236.201456977404, 54046.0, 54142.0, 55318.44681553294, 63026.27302952205, 65158.348416515226, 68008.6599566999, 68764.3123568778, 69726.0, 13095.803562946754, 13233.602991910258, 13306.86693133095, 13331.66670833237, 13591.52429664957, 14554.345054472786, 14733.852661473677, 15120.773188401963, 15150.696986059997, 15355.692886142439, 13569.389377477839, 13744.106633068819, 13994.860051399355, 14307.284635768377, 14440.0, 13827.861721382658, 13936.4425422986, 14126.43494260218, 14470.348834302271, 14489.855101448851, 12689.746205076031, 13497.190168589523, 13549.729005420033, 14028.859711402756, 14049.719005620034, 10840.295380800539, 11219.765825758997, 11254.662360129209, 11505.079593632321, 11633.825492617449, 8786.868196976922, 11084.224104312621, 11356.886431135583, 11360.659180224606, 11369.829452558384], "value": 7611.217247135914, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1626.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 171.0, 155.0, 171.0, 147.0, 116.0, 166.0, 177.0, 136.0, 117.0], "value": 149.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 139.0, 109.0, 185.0, 114.0, 110.0, 140.0, 115.0, 134.0, 109.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 206.0, 257.0, 233.0, 227.0, 282.0, 189.0, 272.0, 278.0, 200.0], "value": 233.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 86.0, 82.0, 95.0, 53.0, 76.0, 83.0, 85.0, 96.0, 53.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 84.0, 73.0, 71.0, 72.0, 80.0, 69.0, 71.0, 81.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 96.0, 117.0, 89.0, 78.0, 135.0, 131.0, 88.0, 86.0], "value": 99.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 131.0, 92.0, 142.0, 145.0, 93.0, 142.0, 142.0, 111.0, 92.0], "value": 118.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 60.0, 62.0, 64.0, 62.0, 63.0, 62.0, 63.0, 64.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 71.0, 88.0, 118.0, 111.0, 101.0, 75.0, 70.0, 73.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 84.0, 84.0, 84.0, 85.0, 86.0, 88.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 146.0, 143.0, 161.0, 154.0, 156.0, 143.0, 193.0, 162.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 188.0, 169.0, 169.0, 184.0, 222.0, 161.0, 220.0, 221.0, 167.0], "value": 189.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 85.0, 66.0, 66.0, 67.0, 66.0, 65.0, 81.0], "value": 70.0, "unit": "score"}]}]} 19:45:41 INFO - Return code: 0 19:45:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:45:41 ERROR - # TBPL SUCCESS # 19:45:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:45:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:45:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:45:41 INFO - 2017-02-07 19:45:41.898 screenresolution[29724:276025] starting screenresolution argv=screenresolution get 19:45:41 INFO - 2017-02-07 19:45:41.901 screenresolution[29724:276025] Display 0: 1600x1200x32@60 19:45:41 INFO - 2017-02-07 19:45:41.907 screenresolution[29725:276028] starting screenresolution argv=screenresolution list 19:45:41 INFO - Available Modes on Display 0 19:45:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:45:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:45:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:45:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:45:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:45:42 INFO - Intel Iris: 19:45:42 INFO - Chipset Model: Intel Iris 19:45:42 INFO - Type: GPU 19:45:42 INFO - Bus: Built-In 19:45:42 INFO - VRAM (Dynamic, Max): 1536 MB 19:45:42 INFO - Vendor: Intel (0x8086) 19:45:42 INFO - Device ID: 0x0a2e 19:45:42 INFO - Revision ID: 0x0009 19:45:42 INFO - Displays: 19:45:42 INFO - Display: 19:45:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:45:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:45:42 INFO - Display Serial Number: 1600x1200 60 19:45:42 INFO - Main Display: Yes 19:45:42 INFO - Mirror: Off 19:45:42 INFO - Online: Yes 19:45:42 INFO - Rotation: Supported 19:45:42 INFO - Return code: 0 19:45:42 INFO - Running post-action listener: _resource_record_post_action 19:45:42 INFO - [mozharness: 2017-02-08 03:45:42.148883Z] Finished run-tests step (success) 19:45:42 INFO - Running post-run listener: _resource_record_post_run 19:45:42 INFO - Total resource usage - Wall time: 1197s; CPU: 55.0%; Read bytes: 29901312; Write bytes: 509683200; Read time: 286; Write time: 1752 19:45:42 INFO - TinderboxPrint: CPU usage
54.6% 19:45:42 INFO - TinderboxPrint: I/O read bytes / time
29,901,312 / 286 19:45:42 INFO - TinderboxPrint: I/O write bytes / time
509,683,200 / 1,752 19:45:42 INFO - TinderboxPrint: CPU idle
2,175.1 (45.4%) 19:45:42 INFO - TinderboxPrint: CPU system
973.1 (20.3%) 19:45:42 INFO - TinderboxPrint: CPU user
1,641.4 (34.3%) 19:45:42 INFO - TinderboxPrint: Swap in / out
231,731,200 / 0 19:45:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205136384; Write bytes: 202610176; Read time: 15829; Write time: 464 19:45:42 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 29430272; Write bytes: 295981056; Read time: 279; Write time: 1255 19:45:42 INFO - Running post-run listener: _upload_blobber_files 19:45:42 INFO - Blob upload gear active. 19:45:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:45:42 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 19:45:42 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'] 19:45:42 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 19:45:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:45:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:43 INFO - (blobuploader) - INFO - Done attempting. 19:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:45:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:44 INFO - (blobuploader) - INFO - Done attempting. 19:45:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:45:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:45:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:45 INFO - (blobuploader) - INFO - Done attempting. 19:45:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:45:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:45:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:48 INFO - (blobuploader) - INFO - Done attempting. 19:45:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:45:48 INFO - Return code: 0 19:45:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:45:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:45:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970957a632010e2daaab505ae19fcc448b59ec0c82a5a9905993bc0f8531ccb085785fee1c1ee6a612bbe1ec7eecab6f1b7d5174491d933e70b2dad5baeb9283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c23be97b921fc5884e41af01561596dc086643957f08bba82a1afb7dd5ae34922c0c680c547ea80ae3c6395496062edfbdf521d34c71001dd98510b686a50a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f781a69259d1612f96e3c1659780cdc54a4bc0c95ed9fcfe0869e6e9e0189d1c278a75275611b19e14450bcec52327de80b82683aac94cb79fd675f1bbc701b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0a3789418d2c5edb7cb0d1e9014aac4605fab2eec1062c333910caf7c48387946ba9977655dee9514fbd79e9b93492d8acdc561e94f719bfebb83ec8610f9"} 19:45:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:45:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:45:48 INFO - Contents: 19:45:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970957a632010e2daaab505ae19fcc448b59ec0c82a5a9905993bc0f8531ccb085785fee1c1ee6a612bbe1ec7eecab6f1b7d5174491d933e70b2dad5baeb9283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c23be97b921fc5884e41af01561596dc086643957f08bba82a1afb7dd5ae34922c0c680c547ea80ae3c6395496062edfbdf521d34c71001dd98510b686a50a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f781a69259d1612f96e3c1659780cdc54a4bc0c95ed9fcfe0869e6e9e0189d1c278a75275611b19e14450bcec52327de80b82683aac94cb79fd675f1bbc701b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0a3789418d2c5edb7cb0d1e9014aac4605fab2eec1062c333910caf7c48387946ba9977655dee9514fbd79e9b93492d8acdc561e94f719bfebb83ec8610f9"} 19:45:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:45:48 INFO - Copying logs to upload dir... 19:45:48 INFO - mkdir: /builds/slave/test/build/upload/logs 19:45:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.894586 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-07 19:45:49.039580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 19:45:49.042773) ========= 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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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/970957a632010e2daaab505ae19fcc448b59ec0c82a5a9905993bc0f8531ccb085785fee1c1ee6a612bbe1ec7eecab6f1b7d5174491d933e70b2dad5baeb9283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c23be97b921fc5884e41af01561596dc086643957f08bba82a1afb7dd5ae34922c0c680c547ea80ae3c6395496062edfbdf521d34c71001dd98510b686a50a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f781a69259d1612f96e3c1659780cdc54a4bc0c95ed9fcfe0869e6e9e0189d1c278a75275611b19e14450bcec52327de80b82683aac94cb79fd675f1bbc701b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0a3789418d2c5edb7cb0d1e9014aac4605fab2eec1062c333910caf7c48387946ba9977655dee9514fbd79e9b93492d8acdc561e94f719bfebb83ec8610f9"} build_url:https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/fG4BB-9jTRWH-vkgb_QxPw/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/970957a632010e2daaab505ae19fcc448b59ec0c82a5a9905993bc0f8531ccb085785fee1c1ee6a612bbe1ec7eecab6f1b7d5174491d933e70b2dad5baeb9283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c23be97b921fc5884e41af01561596dc086643957f08bba82a1afb7dd5ae34922c0c680c547ea80ae3c6395496062edfbdf521d34c71001dd98510b686a50a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f781a69259d1612f96e3c1659780cdc54a4bc0c95ed9fcfe0869e6e9e0189d1c278a75275611b19e14450bcec52327de80b82683aac94cb79fd675f1bbc701b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0a3789418d2c5edb7cb0d1e9014aac4605fab2eec1062c333910caf7c48387946ba9977655dee9514fbd79e9b93492d8acdc561e94f719bfebb83ec8610f9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 19:45:49.082006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 19:45:49.082572) ========= 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.f9PriAe6Wy/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.PD9Qr2Vcus/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 19:45:49.131413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 19:45:49.131762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 19:45:49.132088) ========= ========= Total master_lag: 0.22 =========