builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0226 starttime: 1490496583.83 results: success (0) buildid: 20170325184016 builduid: db823f610039467ea9c398597559edc7 revision: f5e214144799889e2408c4841351f4053f00544e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.834924) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.835310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.835599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.868376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.868735) ========= 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.0GluL0u1GE/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.40snXZyXTi/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-03-25 19:49:43-- 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% 18.5M=0.001s 2017-03-25 19:49:44 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.610180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.502690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.503013) ========= 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.0GluL0u1GE/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.40snXZyXTi/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.027124 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.551900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-25 19:49:44.552249) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f5e214144799889e2408c4841351f4053f00544e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f5e214144799889e2408c4841351f4053f00544e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0GluL0u1GE/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.40snXZyXTi/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-03-25 19:49:44,668 truncating revision to first 12 chars 2017-03-25 19:49:44,668 Setting DEBUG logging. 2017-03-25 19:49:44,668 attempt 1/10 2017-03-25 19:49:44,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f5e214144799?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-25 19:49:46,003 unpacking tar archive at: mozilla-central-f5e214144799/testing/mozharness/ program finished with exit code 0 elapsedTime=1.620112 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-25 19:49:46.195532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.195832) ========= script_repo_revision: f5e214144799889e2408c4841351f4053f00544e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.196243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.196502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.219281) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-25 19:49:46.219709) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0GluL0u1GE/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.40snXZyXTi/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:49:46 INFO - MultiFileLogger online at 20170325 19:49:46 in /builds/slave/test 19:49:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:49:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:49:46 INFO - {'append_to_log': False, 19:49:46 INFO - 'base_work_dir': '/builds/slave/test', 19:49:46 INFO - 'blob_upload_branch': 'Firefox', 19:49:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:49:46 INFO - 'branch': 'Firefox', 19:49:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:46 INFO - 'config_files': ('talos/mac_config.py',), 19:49:46 INFO - 'default_actions': ('clobber', 19:49:46 INFO - 'read-buildbot-config', 19:49:46 INFO - 'download-and-extract', 19:49:46 INFO - 'populate-webroot', 19:49:46 INFO - 'create-virtualenv', 19:49:46 INFO - 'install', 19:49:46 INFO - 'run-tests'), 19:49:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:46 INFO - 'download_minidump_stackwalk': True, 19:49:46 INFO - 'download_symbols': 'ondemand', 19:49:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:46 INFO - 'gecko_profile': False, 19:49:46 INFO - 'gecko_profile_interval': 0, 19:49:46 INFO - 'installer_path': 'installer.exe', 19:49:46 INFO - 'log_level': 'info', 19:49:46 INFO - 'log_name': 'talos', 19:49:46 INFO - 'log_to_console': True, 19:49:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:49:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:49:46 INFO - 'opt_config_files': (), 19:49:46 INFO - 'pip_index': False, 19:49:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:46 INFO - 'cmd': ('bash', 19:49:46 INFO - '-c', 19:49:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:46 INFO - 'enabled': True, 19:49:46 INFO - 'halt_on_failure': False, 19:49:46 INFO - 'name': 'check_screen_resolution'},), 19:49:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:46 INFO - 'cmd': ('bash', 19:49:46 INFO - '-c', 19:49:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:46 INFO - 'enabled': True, 19:49:46 INFO - 'halt_on_failure': False, 19:49:46 INFO - 'name': 'check_screen_resolution'},), 19:49:46 INFO - 'run_cmd_checks_enabled': True, 19:49:46 INFO - 'suite': 'dromaeojs-e10s', 19:49:46 INFO - 'system_bits': '32', 19:49:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:46 INFO - 'title': 't-yosemite-r7-0226', 19:49:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:46 INFO - 'use_talos_json': True, 19:49:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:49:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:46 INFO - 'work_dir': 'build'} 19:49:46 INFO - [mozharness: 2017-03-26 02:49:46.444971Z] Running clobber step. 19:49:46 INFO - Running pre-action listener: _resource_record_pre_action 19:49:46 INFO - Running main action method: clobber 19:49:46 INFO - rmtree: /builds/slave/test/build 19:49:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:49:49 INFO - Running post-action listener: _resource_record_post_action 19:49:49 INFO - [mozharness: 2017-03-26 02:49:49.042849Z] Finished clobber step (success) 19:49:49 INFO - [mozharness: 2017-03-26 02:49:49.043067Z] Running read-buildbot-config step. 19:49:49 INFO - Running pre-action listener: _resource_record_pre_action 19:49:49 INFO - Running main action method: read_buildbot_config 19:49:49 INFO - Using buildbot properties: 19:49:49 INFO - { 19:49:49 INFO - "project": "", 19:49:49 INFO - "product": "firefox", 19:49:49 INFO - "script_repo_revision": "production", 19:49:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:49:49 INFO - "repository": "", 19:49:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:49:49 INFO - "buildid": "20170325184016", 19:49:49 INFO - "pgo_build": "False", 19:49:49 INFO - "basedir": "/builds/slave/test", 19:49:49 INFO - "buildnumber": 28, 19:49:49 INFO - "slavename": "t-yosemite-r7-0226", 19:49:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:49:49 INFO - "platform": "yosemite_r7", 19:49:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:49:49 INFO - "branch": "mozilla-central", 19:49:49 INFO - "repo_path": "mozilla-central", 19:49:49 INFO - "revision": "f5e214144799889e2408c4841351f4053f00544e", 19:49:49 INFO - "stage_platform": "macosx64", 19:49:49 INFO - "builduid": "db823f610039467ea9c398597559edc7", 19:49:49 INFO - "slavebuilddir": "test" 19:49:49 INFO - } 19:49:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:49:49 INFO - Running post-action listener: _resource_record_post_action 19:49:49 INFO - [mozharness: 2017-03-26 02:49:49.048847Z] Finished read-buildbot-config step (success) 19:49:49 INFO - [mozharness: 2017-03-26 02:49:49.048999Z] Running download-and-extract step. 19:49:49 INFO - Running pre-action listener: _resource_record_pre_action 19:49:49 INFO - Running main action method: download_and_extract 19:49:49 INFO - mkdir: /builds/slave/test/build/tests 19:49:49 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:49:49 INFO - trying https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:49:49 INFO - Downloading https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 19:49:50 INFO - Downloaded 1325 bytes. 19:49:50 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:49:50 INFO - Using the following test package requirements: 19:49:50 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:49:50 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:49:50 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:49:50 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:49:50 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'jsshell-mac.zip'], 19:49:50 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:49:50 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:49:50 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:49:50 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:49:50 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:49:50 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:50 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:49:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:49:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:49:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:49:50 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:49:52 INFO - Expected file size: 52411490 19:49:52 INFO - Obtained file size: 52411490 19:50:08 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:50:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:50:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:50:08 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:50:11 INFO - Expected file size: 52411490 19:50:11 INFO - Obtained file size: 52411490 19:50:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:50:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:50:26 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:50:27 INFO - Expected file size: 14404171 19:50:27 INFO - Obtained file size: 14404171 19:50: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:50:27 INFO - trying https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:50:27 INFO - Downloading https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 19:50:29 INFO - Downloaded 75602164 bytes. 19:50:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:50:29 INFO - mkdir: /builds/slave/test/properties 19:50:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:50:29 INFO - Writing to file /builds/slave/test/properties/build_url 19:50:29 INFO - Contents: 19:50:29 INFO - build_url:https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:50:30 INFO - Running post-action listener: _resource_record_post_action 19:50:30 INFO - Running post-action listener: set_extra_try_arguments 19:50:30 INFO - [mozharness: 2017-03-26 02:50:30.530437Z] Finished download-and-extract step (success) 19:50:30 INFO - [mozharness: 2017-03-26 02:50:30.530559Z] Running populate-webroot step. 19:50:30 INFO - Running pre-action listener: _resource_record_pre_action 19:50:30 INFO - Running main action method: populate_webroot 19:50:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:50:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:50:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:50:30 INFO - '--tppagecycles', 19:50:30 INFO - '7'], 19:50:30 INFO - 'tests': ['tsvgm']}}, 19:50:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:50:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:50:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:50:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:50:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:50:30 INFO - 'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:50:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:50:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:50:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:50:30 INFO - 'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['damp', 'tps']}, 19:50:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:50:30 INFO - 'tests': ['damp', 'tps']}, 19:50:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['dromaeo_dom']}, 19:50:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:50:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['basic_compositor_video']}, 19:50:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:50:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['a11yr', 19:50:30 INFO - 'ts_paint', 19:50:30 INFO - 'tpaint', 19:50:30 INFO - 'sessionrestore', 19:50:30 INFO - 'sessionrestore_no_auto_restore', 19:50:30 INFO - 'tabpaint']}, 19:50:30 INFO - 'other-e10s': {'tests': ['a11yr', 19:50:30 INFO - 'ts_paint', 19:50:30 INFO - 'tpaint', 19:50:30 INFO - 'sessionrestore', 19:50:30 INFO - 'sessionrestore_no_auto_restore', 19:50:30 INFO - 'tabpaint']}, 19:50:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:50:30 INFO - 'ts_paint', 19:50:30 INFO - 'tpaint', 19:50:30 INFO - 'sessionrestore', 19:50:30 INFO - 'sessionrestore_no_auto_restore', 19:50:30 INFO - 'tabpaint']}, 19:50:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:50:30 INFO - 'ts_paint', 19:50:30 INFO - 'tpaint', 19:50:30 INFO - 'sessionrestore', 19:50:30 INFO - 'sessionrestore_no_auto_restore', 19:50:30 INFO - 'tabpaint']}, 19:50:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['a11yr', 19:50:30 INFO - 'ts_paint', 19:50:30 INFO - 'tpaint', 19:50:30 INFO - 'sessionrestore', 19:50:30 INFO - 'sessionrestore_no_auto_restore', 19:50:30 INFO - 'tabpaint']}, 19:50:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['a11yr', 19:50:30 INFO - 'ts_paint', 19:50:30 INFO - 'tpaint', 19:50:30 INFO - 'sessionrestore', 19:50:30 INFO - 'sessionrestore_no_auto_restore', 19:50:30 INFO - 'tabpaint']}, 19:50:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['tsvgx', 19:50:30 INFO - 'tsvgr_opacity', 19:50:30 INFO - 'tart', 19:50:30 INFO - 'tscrollx', 19:50:30 INFO - 'cart', 19:50:30 INFO - 'tsvg_static']}, 19:50:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:50:30 INFO - 'tsvgr_opacity', 19:50:30 INFO - 'tart', 19:50:30 INFO - 'tscrollx', 19:50:30 INFO - 'cart', 19:50:30 INFO - 'tsvg_static']}, 19:50:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:50:30 INFO - 'talos_options': ['--disable-e10s'], 19:50:30 INFO - 'tests': ['tp5o']}, 19:50:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:50:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:50:30 INFO - 'talos_options': ['--disable-e10s', 19:50:30 INFO - '--xperf_path', 19:50:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:50:30 INFO - 'tests': ['tp5n']}, 19:50:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:50:30 INFO - 'talos_options': ['--xperf_path', 19:50:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:50:30 INFO - 'tests': ['tp5n']}}, 19:50:30 INFO - 'talos.zip': {'path': '', 19:50:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:50:30 INFO - Running post-action listener: _resource_record_post_action 19:50:30 INFO - [mozharness: 2017-03-26 02:50:30.549298Z] Finished populate-webroot step (success) 19:50:30 INFO - [mozharness: 2017-03-26 02:50:30.549411Z] Running create-virtualenv step. 19:50:30 INFO - Running pre-action listener: _resource_record_pre_action 19:50:30 INFO - Running main action method: create_virtualenv 19:50:30 INFO - Creating virtualenv /builds/slave/test/build/venv 19:50:30 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:50:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:50:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:50:30 INFO - Using real prefix '/tools/python27' 19:50:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:50:31 INFO - Installing distribute.............................................................................................................................................................................................done. 19:50:34 INFO - Installing pip.................done. 19:50:34 INFO - Return code: 0 19:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:50:34 INFO - Reading from file tmpfile_stdout 19:50:34 INFO - Output received: 19:50:34 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:50:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:34 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50:34 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:50:34 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:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:34 INFO - 'HOME': '/Users/cltbld', 19:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:34 INFO - 'LOGNAME': 'cltbld', 19:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:34 INFO - 'MOZ_NO_REMOTE': '1', 19:50:34 INFO - 'NO_EM_RESTART': '1', 19:50:34 INFO - 'PAGER': '/bin/cat', 19:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:34 INFO - 'PWD': '/builds/slave/test', 19:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:34 INFO - 'SHELL': '/bin/bash', 19:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:34 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:34 INFO - 'USER': 'cltbld', 19:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:34 INFO - 'XPC_FLAGS': '0x0', 19:50:34 INFO - 'XPC_SERVICE_NAME': '0', 19:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:34 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:50:34 INFO - Cleaning up... 19:50:34 INFO - Return code: 0 19:50:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:34 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50:34 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:50:34 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:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:34 INFO - 'HOME': '/Users/cltbld', 19:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:34 INFO - 'LOGNAME': 'cltbld', 19:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:34 INFO - 'MOZ_NO_REMOTE': '1', 19:50:34 INFO - 'NO_EM_RESTART': '1', 19:50:34 INFO - 'PAGER': '/bin/cat', 19:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:34 INFO - 'PWD': '/builds/slave/test', 19:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:34 INFO - 'SHELL': '/bin/bash', 19:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:34 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:34 INFO - 'USER': 'cltbld', 19:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:34 INFO - 'XPC_FLAGS': '0x0', 19:50:34 INFO - 'XPC_SERVICE_NAME': '0', 19:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:35 INFO - Downloading/unpacking psutil>=3.1.1 19:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:50:39 INFO - Installing collected packages: psutil 19:50:39 INFO - Running setup.py install for psutil 19:50:39 INFO - building 'psutil._psutil_osx' extension 19:50:39 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:50:39 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:50:39 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:50:39 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:50:39 INFO - building 'psutil._psutil_posix' extension 19:50:39 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:50:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:50:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:50:40 INFO - ^ 19:50:40 INFO - 1 warning generated. 19:50:40 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:50:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:50:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:50:40 INFO - Successfully installed psutil 19:50:40 INFO - Cleaning up... 19:50:40 INFO - Return code: 0 19:50:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:40 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50:40 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:50:40 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:50:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:40 INFO - 'HOME': '/Users/cltbld', 19:50:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:40 INFO - 'LOGNAME': 'cltbld', 19:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:40 INFO - 'MOZ_NO_REMOTE': '1', 19:50:40 INFO - 'NO_EM_RESTART': '1', 19:50:40 INFO - 'PAGER': '/bin/cat', 19:50:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:40 INFO - 'PWD': '/builds/slave/test', 19:50:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:40 INFO - 'SHELL': '/bin/bash', 19:50:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:40 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:40 INFO - 'USER': 'cltbld', 19:50:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:40 INFO - 'XPC_FLAGS': '0x0', 19:50:40 INFO - 'XPC_SERVICE_NAME': '0', 19:50:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:50:43 INFO - Installing collected packages: mozsystemmonitor 19:50:43 INFO - Running setup.py install for mozsystemmonitor 19:50:43 INFO - Successfully installed mozsystemmonitor 19:50:43 INFO - Cleaning up... 19:50:43 INFO - Return code: 0 19:50:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:50: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:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50: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:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50: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==2.5.1'] in /builds/slave/test/build 19:50: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==2.5.1 19:50:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:43 INFO - 'HOME': '/Users/cltbld', 19:50:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:43 INFO - 'LOGNAME': 'cltbld', 19:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:43 INFO - 'MOZ_NO_REMOTE': '1', 19:50:43 INFO - 'NO_EM_RESTART': '1', 19:50:43 INFO - 'PAGER': '/bin/cat', 19:50:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:43 INFO - 'PWD': '/builds/slave/test', 19:50:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:43 INFO - 'SHELL': '/bin/bash', 19:50:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:43 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:43 INFO - 'USER': 'cltbld', 19:50:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:43 INFO - 'XPC_FLAGS': '0x0', 19:50:43 INFO - 'XPC_SERVICE_NAME': '0', 19:50:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:43 INFO - Downloading/unpacking jsonschema==2.5.1 19:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:50:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:50:47 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:50:47 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:50:47 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:50:47 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:50:47 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:50:47 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:50:47 INFO - Downloading functools32-3.2.3-2.tar.gz 19:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:50:47 INFO - warning: no files found matching '*.txt' 19:50:47 INFO - no previously-included directories found matching 'build' 19:50:47 INFO - no previously-included directories found matching 'dist' 19:50:47 INFO - no previously-included directories found matching '.git*' 19:50:47 INFO - Installing collected packages: jsonschema, functools32 19:50:47 INFO - Running setup.py install for functools32 19:50:47 INFO - warning: no files found matching '*.txt' 19:50:47 INFO - no previously-included directories found matching 'build' 19:50:47 INFO - no previously-included directories found matching 'dist' 19:50:47 INFO - no previously-included directories found matching '.git*' 19:50:47 INFO - Successfully installed jsonschema functools32 19:50:47 INFO - Cleaning up... 19:50:48 INFO - Return code: 0 19:50:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:48 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50:48 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:50:48 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:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:48 INFO - 'HOME': '/Users/cltbld', 19:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:48 INFO - 'LOGNAME': 'cltbld', 19:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:48 INFO - 'MOZ_NO_REMOTE': '1', 19:50:48 INFO - 'NO_EM_RESTART': '1', 19:50:48 INFO - 'PAGER': '/bin/cat', 19:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:48 INFO - 'PWD': '/builds/slave/test', 19:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:48 INFO - 'SHELL': '/bin/bash', 19:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:48 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:48 INFO - 'USER': 'cltbld', 19:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:48 INFO - 'XPC_FLAGS': '0x0', 19:50:48 INFO - 'XPC_SERVICE_NAME': '0', 19:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:50:48 INFO - Cleaning up... 19:50:48 INFO - Return code: 0 19:50:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:48 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50:48 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:50:48 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:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:48 INFO - 'HOME': '/Users/cltbld', 19:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:48 INFO - 'LOGNAME': 'cltbld', 19:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:48 INFO - 'MOZ_NO_REMOTE': '1', 19:50:48 INFO - 'NO_EM_RESTART': '1', 19:50:48 INFO - 'PAGER': '/bin/cat', 19:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:48 INFO - 'PWD': '/builds/slave/test', 19:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:48 INFO - 'SHELL': '/bin/bash', 19:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:48 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:48 INFO - 'USER': 'cltbld', 19:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:48 INFO - 'XPC_FLAGS': '0x0', 19:50:48 INFO - 'XPC_SERVICE_NAME': '0', 19:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:50:48 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:50:48 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:50:48 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:50:48 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:50:48 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:50:48 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:50:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:50:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:50:51 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:50:51 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:50:51 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:50:51 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:50:51 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:50:51 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:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:50:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:50:51 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:50:51 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:50:51 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:50:51 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:50:51 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:50:51 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:50:52 INFO - Downloading docopt-0.6.1.tar.gz 19:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:50:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:50:52 INFO - Running setup.py install for blobuploader 19:50:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:50:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:50:52 INFO - Running setup.py install for requests 19:50:53 INFO - Running setup.py install for docopt 19:50:53 INFO - Successfully installed blobuploader requests docopt 19:50:53 INFO - Cleaning up... 19:50:53 INFO - Return code: 0 19:50:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:53 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50:53 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:50:53 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:50:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:53 INFO - 'HOME': '/Users/cltbld', 19:50:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:53 INFO - 'LOGNAME': 'cltbld', 19:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:53 INFO - 'MOZ_NO_REMOTE': '1', 19:50:53 INFO - 'NO_EM_RESTART': '1', 19:50:53 INFO - 'PAGER': '/bin/cat', 19:50:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:53 INFO - 'PWD': '/builds/slave/test', 19:50:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:53 INFO - 'SHELL': '/bin/bash', 19:50:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:53 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:53 INFO - 'USER': 'cltbld', 19:50:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:53 INFO - 'XPC_FLAGS': '0x0', 19:50:53 INFO - 'XPC_SERVICE_NAME': '0', 19:50:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:53 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-I6qGUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:53 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-9veGad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:53 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-G5bXA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:53 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ZiVnSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-y1Acz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-xCfv6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-4a8ln8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-rLts65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-EXIBRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-8WHzlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Vryw1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-74kEo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-978Bt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:54 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-eUuFNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:55 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-qwq6Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:55 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-LQWjUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:55 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-AAlcl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:50:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:50:55 INFO - Running setup.py install for manifestparser 19:50:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Running setup.py install for mozcrash 19:50:55 INFO - Running setup.py install for mozdebug 19:50:55 INFO - Running setup.py install for mozdevice 19:50:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Running setup.py install for mozfile 19:50:56 INFO - Running setup.py install for mozhttpd 19:50:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Running setup.py install for mozinfo 19:50:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Running setup.py install for mozInstall 19:50:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Running setup.py install for mozleak 19:50:56 INFO - Running setup.py install for mozlog 19:50:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Running setup.py install for moznetwork 19:50:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:50:57 INFO - Running setup.py install for mozprocess 19:50:57 INFO - Running setup.py install for mozprofile 19:50:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:50:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:50:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:50:57 INFO - Running setup.py install for mozrunner 19:50:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:50:57 INFO - Running setup.py install for mozscreenshot 19:50:57 INFO - Running setup.py install for moztest 19:50:57 INFO - Running setup.py install for mozversion 19:50:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:50:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:50:57 INFO - Cleaning up... 19:50:57 INFO - Return code: 0 19:50:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:57 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:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:57 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:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:57 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:50:57 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:50:57 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:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:57 INFO - 'HOME': '/Users/cltbld', 19:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:57 INFO - 'LOGNAME': 'cltbld', 19:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:57 INFO - 'MOZ_NO_REMOTE': '1', 19:50:57 INFO - 'NO_EM_RESTART': '1', 19:50:57 INFO - 'PAGER': '/bin/cat', 19:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:57 INFO - 'PWD': '/builds/slave/test', 19:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:57 INFO - 'SHELL': '/bin/bash', 19:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:50:57 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:57 INFO - 'USER': 'cltbld', 19:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:57 INFO - 'XPC_FLAGS': '0x0', 19:50:57 INFO - 'XPC_SERVICE_NAME': '0', 19:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-4pLjod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:58 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:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-SmCSeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:58 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:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-tVMFze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:58 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:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-0MUhaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:58 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:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-2L0mO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:58 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:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-cz7YEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:58 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:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-MS1M7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:58 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:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:58 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-fhgjDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-L1uWx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-kQH9BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-QopOSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-aWgVRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-_Ru2xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Uyyi_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-zL6Avj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-DhDVik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:59 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:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:59 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-02nEs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:02 INFO - Downloading blessings-1.6.tar.gz 19:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:02 INFO - Installing collected packages: blessings 19:51:02 INFO - Running setup.py install for blessings 19:51:02 INFO - Successfully installed blessings 19:51:02 INFO - Cleaning up... 19:51:03 INFO - Return code: 0 19:51:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:03 INFO - Reading from file tmpfile_stdout 19:51:03 INFO - Current package versions: 19:51:03 INFO - blessings == 1.6 19:51:03 INFO - blobuploader == 1.2.4 19:51:03 INFO - docopt == 0.6.1 19:51:03 INFO - functools32 == 3.2.3-2 19:51:03 INFO - jsonschema == 2.5.1 19:51:03 INFO - manifestparser == 1.1 19:51:03 INFO - mozInstall == 1.12 19:51:03 INFO - mozcrash == 1.0 19:51:03 INFO - mozdebug == 0.1 19:51:03 INFO - mozdevice == 0.49 19:51:03 INFO - mozfile == 1.2 19:51:03 INFO - mozhttpd == 0.7 19:51:03 INFO - mozinfo == 0.9 19:51:03 INFO - mozleak == 0.1 19:51:03 INFO - mozlog == 3.4 19:51:03 INFO - moznetwork == 0.27 19:51:03 INFO - mozprocess == 0.25 19:51:03 INFO - mozprofile == 0.28 19:51:03 INFO - mozrunner == 6.13 19:51:03 INFO - mozscreenshot == 0.1 19:51:03 INFO - mozsystemmonitor == 0.3 19:51:03 INFO - moztest == 0.8 19:51:03 INFO - mozversion == 1.4 19:51:03 INFO - psutil == 3.1.1 19:51:03 INFO - requests == 1.2.3 19:51:03 INFO - wsgiref == 0.1.2 19:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:03 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:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:03 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:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:03 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:51:03 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:51:03 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:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:03 INFO - 'HOME': '/Users/cltbld', 19:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:03 INFO - 'LOGNAME': 'cltbld', 19:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:03 INFO - 'MOZ_NO_REMOTE': '1', 19:51:03 INFO - 'NO_EM_RESTART': '1', 19:51:03 INFO - 'PAGER': '/bin/cat', 19:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:03 INFO - 'PWD': '/builds/slave/test', 19:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:03 INFO - 'SHELL': '/bin/bash', 19:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:51:03 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:03 INFO - 'USER': 'cltbld', 19:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:03 INFO - 'XPC_FLAGS': '0x0', 19:51:03 INFO - 'XPC_SERVICE_NAME': '0', 19:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 INFO - Cleaning up... 19:51:03 INFO - Return code: 0 19:51:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:51:03 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:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:03 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:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:03 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 0x10daa1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa85855e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, '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.0GluL0u1GE/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.40snXZyXTi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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:51:03 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:51:03 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:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:03 INFO - 'HOME': '/Users/cltbld', 19:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:03 INFO - 'LOGNAME': 'cltbld', 19:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:03 INFO - 'MOZ_NO_REMOTE': '1', 19:51:03 INFO - 'NO_EM_RESTART': '1', 19:51:03 INFO - 'PAGER': '/bin/cat', 19:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:03 INFO - 'PWD': '/builds/slave/test', 19:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:03 INFO - 'SHELL': '/bin/bash', 19:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:51:03 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:03 INFO - 'USER': 'cltbld', 19:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:03 INFO - 'XPC_FLAGS': '0x0', 19:51:03 INFO - 'XPC_SERVICE_NAME': '0', 19:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:51:03 INFO - Cleaning up... 19:51:03 INFO - Return code: 0 19:51:03 INFO - Running post-action listener: _resource_record_post_action 19:51:03 INFO - Running post-action listener: _start_resource_monitoring 19:51:03 INFO - Starting resource monitoring. 19:51:03 INFO - [mozharness: 2017-03-26 02:51:03.879866Z] Finished create-virtualenv step (success) 19:51:03 INFO - [mozharness: 2017-03-26 02:51:03.880881Z] Running install step. 19:51:03 INFO - Running pre-action listener: _resource_record_pre_action 19:51:03 INFO - Running main action method: install 19:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:04 INFO - Reading from file tmpfile_stdout 19:51:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:51:04 INFO - Reading from file tmpfile_stdout 19:51:04 INFO - Output received: 19:51:04 INFO - Usage: mozinstall [options] installer 19:51:04 INFO - Options: 19:51:04 INFO - -h, --help show this help message and exit 19:51:04 INFO - -d DEST, --destination=DEST 19:51:04 INFO - Directory to install application into. [default: 19:51:04 INFO - "/builds/slave/test"] 19:51:04 INFO - --app=APP Application being installed. [default: firefox] 19:51:04 INFO - mkdir: /builds/slave/test/build/application 19:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:51:24 INFO - Reading from file tmpfile_stdout 19:51:24 INFO - Output received: 19:51:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:51:24 INFO - Running post-action listener: _resource_record_post_action 19:51:24 INFO - [mozharness: 2017-03-26 02:51:24.306029Z] Finished install step (success) 19:51:24 INFO - [mozharness: 2017-03-26 02:51:24.306161Z] Running run-tests step. 19:51:24 INFO - Running pre-action listener: _resource_record_pre_action 19:51:24 INFO - Running main action method: run_tests 19:51:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:51:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:51:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:51:24 INFO - 2017-03-25 19:51:24.320 screenresolution[1628:8427] starting screenresolution argv=screenresolution get 19:51:24 INFO - 2017-03-25 19:51:24.323 screenresolution[1628:8427] Display 0: 1600x1200x32@60 19:51:24 INFO - 2017-03-25 19:51:24.329 screenresolution[1629:8430] starting screenresolution argv=screenresolution list 19:51:24 INFO - Available Modes on Display 0 19:51:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:51:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:51:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:51:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:51:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:51:24 INFO - Intel Iris: 19:51:24 INFO - Chipset Model: Intel Iris 19:51:24 INFO - Type: GPU 19:51:24 INFO - Bus: Built-In 19:51:24 INFO - VRAM (Dynamic, Max): 1536 MB 19:51:24 INFO - Vendor: Intel (0x8086) 19:51:24 INFO - Device ID: 0x0a2e 19:51:24 INFO - Revision ID: 0x0009 19:51:24 INFO - Displays: 19:51:24 INFO - Display: 19:51:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:51:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:51:24 INFO - Display Serial Number: 1600x1200 60 19:51:24 INFO - Main Display: Yes 19:51:24 INFO - Mirror: Off 19:51:24 INFO - Online: Yes 19:51:24 INFO - Rotation: Supported 19:51:24 INFO - Return code: 0 19:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:51:24 INFO - Python 2.7.3 19:51:24 INFO - Return code: 0 19:51:24 INFO - grabbing minidump binary from tooltool 19:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:24 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 0x10d87fd30>, '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 0x10d7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d874be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:51:24 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:51:24 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:51:24 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:51:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:51:24 INFO - Return code: 0 19:51:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:51:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:51:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:51:24 INFO - ENV: RUST_BACKTRACE is now 1 19:51:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:51:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--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:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0226 --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:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GluL0u1GE/Render', 19:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:24 INFO - 'HOME': '/Users/cltbld', 19:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:24 INFO - 'LOGNAME': 'cltbld', 19:51:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:51:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:24 INFO - 'MOZ_NO_REMOTE': '1', 19:51:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:51:24 INFO - 'NO_EM_RESTART': '1', 19:51:24 INFO - 'PAGER': '/bin/cat', 19:51:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:24 INFO - 'PWD': '/builds/slave/test', 19:51:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:24 INFO - 'RUST_BACKTRACE': '1', 19:51:24 INFO - 'SHELL': '/bin/bash', 19:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40snXZyXTi/Listeners', 19:51:24 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 19:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:24 INFO - 'USER': 'cltbld', 19:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:24 INFO - 'XPC_FLAGS': '0x0', 19:51:24 INFO - 'XPC_SERVICE_NAME': '0', 19:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--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:51:24 INFO - mozversion application_buildid: 20170325184016 19:51:24 INFO - mozversion application_changeset: f5e214144799889e2408c4841351f4053f00544e 19:51:24 INFO - mozversion application_display_name: Nightly 19:51:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:51:24 INFO - mozversion application_name: Firefox 19:51:24 INFO - mozversion application_remotingname: firefox 19:51:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:51:24 INFO - mozversion application_vendor: Mozilla 19:51:24 INFO - mozversion application_version: 55.0a1 19:51:24 INFO - mozversion platform_buildid: 20170325184016 19:51:24 INFO - mozversion platform_changeset: f5e214144799889e2408c4841351f4053f00544e 19:51:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:51:24 INFO - mozversion platform_version: 55.0a1 19:51:24 INFO - using testdate: 1490496684 19:51:24 INFO - actual date: 1490496684 19:51:24 INFO - starting webserver on 'localhost:49243' 19:51:24 INFO - SUITE-START | Running 2 tests 19:51:24 INFO - TEST-START | dromaeo_css 19:51:24 INFO - operating with platform_type : mac_ 19:51:24 INFO - Initialising browser for dromaeo_css test... 19:51:24 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpWTNzu9/profile http://localhost:49243/getInfo.html) 19:51:27 INFO - PID 1639 | 2017-03-25 19:51:27.956 plugin-container[1641:8612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 19:51:27 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:51:27 INFO - PID 1639 | 2017-03-25 19:51:27.958 plugin-container[1641:8612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 19:51:27 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:51:27 INFO - PID 1639 | 2017-03-25 19:51:27.958 plugin-container[1641:8612] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:51:28 INFO - PID 1639 | __metrics Screen width/height:1600/1200 19:51:28 INFO - PID 1639 | colorDepth:24 19:51:28 INFO - PID 1639 | Browser inner width/height: 1024/689 19:51:28 INFO - PID 1639 | __metrics 19:51:28 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 19:51:28 ERROR - PID 1639 | 1490496688144 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < forceQuit@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpWTNzu9/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpWTNzu9/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpWTNzu9/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpWTNzu9/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:51:28 INFO - TEST-INFO | 1639: exit 0 19:51:28 INFO - Browser initialized. 19:51:28 INFO - Running cycle 1/1 for dromaeo_css test... 19:51:28 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpWTNzu9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:51:31 INFO - PID 1643 | 2017-03-25 19:51:31.437 plugin-container[1644:8748] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 19:51:31 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:51:31 INFO - PID 1643 | 2017-03-25 19:51:31.439 plugin-container[1644:8748] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 19:51:31 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:51:31 INFO - PID 1643 | 2017-03-25 19:51:31.439 plugin-container[1644:8748] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:51:41 INFO - PID 1643 | RSS: Main: 227799040 19:51:41 INFO - PID 1643 | 19:54:44 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 19:54:46 INFO - PID 1643 | RSS: Main: 250982400 19:54:46 INFO - PID 1643 | 19:56:29 INFO - PID 1643 | ************************* 19:56:29 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1643 | 19:56:29 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1643 | Full stack: 19:56:29 INFO - PID 1643 | ************************* 19:56:29 INFO - PID 1643 | ************************* 19:56:29 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1643 | 19:56:29 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1643 | Full stack: 19:56:29 INFO - PID 1643 | ************************* 19:56:29 INFO - PID 1643 | ************************* 19:56:29 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1643 | 19:56:29 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1643 | Full stack: 19:56:29 INFO - PID 1643 | ************************* 19:56:29 INFO - PID 1643 | ************************* 19:56:29 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1643 | 19:56:29 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1643 | Full stack: 19:56:29 INFO - PID 1643 | ************************* 19:57:48 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 19:57:49 INFO - PID 1643 | RSS: Main: 259682304 19:57:49 INFO - PID 1643 | 20:00:51 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 20:00:52 INFO - PID 1643 | RSS: Main: 270798848 20:00:52 INFO - PID 1643 | 20:03:53 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 20:03:54 INFO - PID 1643 | RSS: Main: 263086080 20:03:54 INFO - PID 1643 | 20:06:57 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 20:06:58 INFO - PID 1643 | RSS: Main: 274137088 20:06:58 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 20:10:01 INFO - PID 1643 | RSS: Main: 267935744 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | __start_tp_report 20:10:01 INFO - PID 1643 | _x_x_mozilla_page_load 20:10:01 INFO - PID 1643 | _x_x_mozilla_page_load_details 20:10:01 INFO - PID 1643 | |i|pagename|runs| 20:10:01 INFO - PID 1643 | |0;dojo.html;2854.3577695018625;3506.5266189064487;3549.840257188426;3568.286342731454;3615.6926661233792;6143.969280153593;6207.906881396777;6217.440430361272;6260.436560709535;6276.529260305472;6128.442013630949;6155.8768824623485;6201.193844800181;6223.190985171933;6314.431701146896;5283.154695248761;5587.3015873015875;5609.971950140243;5613.775448982035;5733.655980641154;5576.470235327637;5669.433056694339;5707.3721890592005;5709.571782116337;5796.797112101077;5506.284183056177;5549.667019978774;5594.356648985378;5635.718214089279;5692.459216374438;5552.500274975271;5577.2191893135;5661.745221465003;5687.0900655895275;5693.914591281134;5470.878469913659;5496.203050557647;5579.581531385163;5580.972095139498;5613.129964855454;5131.870988382587;6068.848278793022;6193.473554747852;6234.750609975596;6237.469815065725;6378.138951241615;6472.385123413268;6590.439812615886;6633.237177724575;6636.070950066995;6737.124173857416;6765.898511522331;6784.966075169642;6785;6792.728290868359;6203.720832562545;6320.304766475684;6354.491640668782;6355.459785918202;6371.139896113966;6628.304028077079;6724.159480064992;6814.62519561419;6831.351021652935;6921.93078069223;5578.525825304894;6138;6366.554341196072;6389.488840892717;6526.184226971629;6609.339066093448;6729.327067293231;6732;6739.123913891162;6771.932280677229;6337.366263373626;6652.467802575782;6680.164979377578;6708.228553716288;6718.22740384862;6057.7879774207695;6413.230412350548;6510.056041873901;6513.250976137805;6614.933850661432;5331.44019877915;5370.838874833761;5379.892402152013;5381;5404.567634589223;4751.358566593535;4771.355866957916;4771.785269662873;4793.712377257376;4830.275458681226;6148.616561273678;6170.012797952306;6256.7810126645345;6279.497640188774;6286.339934306923;6699.631520266432;6720.563163394364;6735.393814556714;6758.121444212221;6783.38949494538;6269.968650156811;6283.59156654816;6296.244450665949;6303.495720342362;6317.9684101580115;5792.768289268466;5902.970485147547;5941.70291485424;5986.820395388146;5987.730552125077;6731.596104233761;6799.082123913407;6851.760188393382;6857.759978400732;6878.312168783082;6739.056532085414;6750.729970801113;6780.525363224724;6781.491388145811;6783.525153239423;6783.050372947692;6815.727370905307;6864.485163612849;6892.931070689429;6917.23910369869;5457.372402173642;6404.71178796946;6406.5515413920575;6507.089007538853;6532.9346706534225;5567.721613919207;5588.86027849307;6577.14497115372;6728.226253980659;6807.965960170168;6198.264883794998;6371.776987805404;6513.511486638616;6531.771388001397;6547.9672601636685;5752.252207213036;6239.844003899939;6300;6343.270523889812;6414.069959855888;6135.294441139147;6238.126662267196;6311.652859092794;6316.905246421399;6327.810165695037;6350.301466838737;6403.679816009274;6408.711607977559;6437.356264373525;6459.160309159967;5636.8162685834795;6047.818565443044;6356.396142366468;6387.233531976192;6396.808095757135 20:10:01 INFO - PID 1643 | |1;ext.html;752.567273817555;806.4274365200707;831.3847752663028;1167.702235929839;1290.8321918150646;37534.249315013716;38308.425373619386;38531.42202866959;38594.421083683694;38684.03289917753;37847.810760946224;38234;38254.42618360727;38348.808255958684;38489.80755096228;8137.75586732396;8235.052968908562;8510.78723031926;8721.694740684077;8772.56137193141;8646.740597782045;8738.519381434018;8781.209691127797;8784.472931624123;8809.955950220272;8745.125487451267;8797.47215167092;8806.471611703286;8817.823643527126;8818.735437936872;8113.553754543498;8460;8794.252488538483;8903.643854245822;8927.553622318857;8586.78533036679;8602;8670.263027642657;8679.566021698953;8701.47791132534;36351;38002.80998595017;38615.03462413434;38797;38896.22207555833;2630.487055024271;3044.528098144791;3066.8313242771637;3091.845407729627;3106.301082256497;27471.313217169532;27747.72252277492;27800.443991120268;27841;28566.00018999325;2823.6344251320284;2828.8444135572536;2834.3339315260896;2844.2036229855676;2910.8690108945148;340130;342486;342941;343705.28147359355;344086;49434.752826236356;49698;49702;49816.50183498119;49905.25331613376;52044.73977630088;52382.476175238524;52499.21251181235;52516.94966100657;52642.73678631582;14386.568402947929;14492.927535362256;14559.708805823824;14582.854171458363;14595.854041459663;9736.853947190797;11776;11799.705007374885;11799.88200118005;11802.350870702194;11633.825492617618;12041;13587.52443664467;13590.660233494043;13647.931760341135;5416.512513873691;5891.7937872175125;5904.881902362014;5908.261467316585;5945.821625351246;887.4985633117268;989.851522271665;993.1161266472845;997.7256254529917;1021.596469394585;20563.794362056487;24247.908844102058;24372.634410483857;24515.509689806462;24518.387040323778;839.5256679975917;911.521451238092;1076.6985244131656;1110.9222354435112;1127.5546159267044;11847.881521184678;12312.13815032939;12464.376781160905;12487.875121248671;12509.874901251053;465726;468508;469192;469591;470170;51819;53711.12011079671;54690.179647305325;55159;55442.61393465115;1193.9044876409866;1461.3935216884875;1471.8601732835364;1510.01848798282;1524.687439074987;19074.618507630046;27527.31181720473;28619.28451788722;29018.854905725337;29363.85318073396;37781.244375112896;37973;37983.240335193696;37990.62009379871;37993.62006379901;354272;357181;358894;359080;359772.2011389926;31053.913113040937;31461.213469663442;31729.5240571387;32200.35599288048;32208;41444;41567;41573.58426415697;41617.79191104025;42117.368239477044;23415.41461463477;27612.447751045267;28105.57841632418;28146;29174.56238156387;29723.85138074296;29765;30410.239744006576;30663;30686.079417617508;32902.34195316128;34626.48060279048;36388.636113638524;36615.63384366122;36729.14343993842;23835;28011.57982630303;29008.709912900602;29661.5550766743;30009.699903000692;22200.333989980325;23171.420714482272;23177;23689.05243790229;23718 20:10:01 INFO - PID 1643 | |2;jquery.html;384.94803201567817;417.75959571652027;432.38817073840517;442.47566633539253;447.5144468251946;18980.905095474536;20521.589568208627;21416.35750927471;21554.56890862182;21633.67549486757;17322.826771732278;17974.5506362341;20920.101679708925;22425.766582837936;22668.319950401514;6091.238595175603;6318.905216421735;6360.332165122665;6364.395382438661;6373.968130159343;5866.76532938682;6096.725647345858;6160.1683772690785;6195.504359651217;6332.683365831713;6108.541859360544;6120.540959428038;6121.112438696387;6124.908126378085;6133.264008319008;6082.9391706082815;6086.969565152168;6101.511879049665;6174.444300012976;6186.628802271878;4616.28447590624;5375.354957405137;5406.270153529263;5442.700651464168;5449.700266485342;26190.607140892902;26401.3399665008;26918.654067296753;27523.036693715625;27791.444171116666;2027.8377729781582;2051.661475856482;2052.0868213644935;2054.4042227753935;2091.0381224636685;15192.696146077127;15704.450344237897;15720.764188537181;16116;16720;1637.3859802574034;1656.6355401811702;1657.4199030339405;1681.0838093239213;1709.384621536246;128672;132122.3393883034;141662;162571;177282;11952.940235298767;12035.458404371824;12191.817122743167;12336.32150231728;12508.74982500345;15739.213039347987;15778.605534861721;15804.209789510709;15821.892467527163;15823.525294241192;8764.079771623889;8994.415363001384;9089.77275568116;9182.586783594754;9221.446713197229;8804.8679269811;8809;8821.2060914518;8983.191512763751;9002.684906028258;7602.8099297518;7738.690452381842;7785.299323060838;7806.804829879185;7819.648115834687;2060.11499477976;2157.676348547699;2168.4578855286177;2169.0564604396823;2317.7450480447137;749.6326799868134;858.626497473601;927.1284992107397;928.3919033033374;933.7058826469777;19752;20147.19411223564;20401.795982040287;20461.89769051145;20542.69185962212;865.7835541114721;968.970930872075;980.960182206863;1003.2826529031631;1014.700663304327;7653.502522336031;9937.205023598095;10524.473776311153;10592.96432227302;10837;398205;569992.3503442272;719746;730398.8720789494;733246;157648.02343777323;160260;161053.19473402793;162026;165530;1023.4933707814531;1156.1700295573266;1186.7507823357191;1201.4953719437858;1203.6990752311922;17540.82459175443;17695.646087078443;17750.556236094202;17778.822211778235;18014;62261;62881;63591;63676.044859328074;63856.36143638504;83771;84115;84665;84762;90370.09629903617;8088.8271200676745;8148.714794982147;8172.509649421054;8557.657693692183;8609.65561377538;10772.299800512941;12266.509339626671;12373.75252494927;12730;13062.34688265602;11035.83446248323;11202.831957520806;11276.26704264253;11389.316641001566;11449.828252576051;10422;10508.632197873038;10655.602489439814;10662.680119596425;10857.077148442471;10523.473826308807;11091.889081109086;11457.427128643702;11540.307581545134;11642.941785291358;7206.918962155509;8072.112067672669;8093.069297030681;8167.101618822044;8471.237588617054;10681.412522311037;10706.678799636024;11277.887221128012;11532.077433805443;11614.70963225926 20:10:01 INFO - PID 1643 | |3;mootools.html;1166.9241499302545;1408.267700795587;1422.0898624880072;1430.3992323224245;1441.020106327697;10440.791184176313;10837.241393102486;10861.40262285574;10895.346279223242;11125;10663.733406664836;11031.669049928494;11136.164787640919;11140.777184456327;11154.386508742016;2393.32986763706;2422.8667423291713;2432.20953190213;2432.5378178146098;2442.8167887408426;2352.541254455382;2433.2700189943034;2450.8529488230674;2451.240115564172;2454.607262837946;2371.833971621987;2434.6104623260194;2437.2931849763636;2439.329184474275;2442.2917353967327;1974.9802501974941;2051.1180192517213;2412.6622272881723;2419.52819200256;2447.938801529967;2035.3283416472677;2373.7982271506944;2419.0444774314046;2428.1986944308337;2436.768506991833;10860.239783215178;10931.508082136243;10972.396518191495;10978.066864316543;10978.956999085074;6145.4161854623735;6381.617102973836;6385.872282554323;6418.967905160444;6463.256725476584;3968.0873399118077;4020.9746514638873;4062.4921884764403;4084.611961863618;4100.712950093465;1168.772089442559;1172.9003034742057;1197.4312201704208;1220.7680540697238;1229.2071613809132;13660;14134.36395362211;15172.848271517365;15339.693206135926;15372.077675339515;5206.323177986837;5316.415194328621;5464.3442786865035;5493.642913210709;5513.145462453326;11229.606963756229;11282.830757538644;11302.717432064099;11328.150388720878;11335.263207891461;5212.40057393397;5512.4211957744665;6290.276618188876;6301.117843501914;6309.716062777186;4845.013544446831;5448.182772584065;5816.82549523515;6012.939870601325;6039.818805435844;4240.660747140221;4299.97850010748;4301.333293339538;4312.37470566766;4368.60682538573;1252.7557126360273;1265.1776345375395;1269.9262431596464;1277.1826031339765;1287.060445874498;760.81360066784;779.5050143159021;785.1520358013332;786.7167819584945;796.3987189671876;5220.712860792617;5281.815136470205;5499.5976026113085;5965.642061476326;6100.847478812976;567.222904620664;579.2469789274011;584.5732615190849;588.1706793421341;600.3726106219011;3087.9382412352074;4136.958630413717;4151;4158.189153115113;4259.61663450291;13295.401706923212;13786.172829630254;13910.930445347709;13929.930350348184;13984;13068.477260909647;13690.863091369158;13768.449262029608;13826.308684565933;13826.377812998438;10146.340487868265;10371.844422333672;10387.065164135112;10392.324498907547;10410.47947602632;5667;6654.201495820533;6751.45988320943;6795.59226446395;6862.073620061228;12009.279443233434;12255.877441225473;12291.938540307241;12337;12445.813312800134;12092.516299348279;12262.87737122653;12320.130949133278;12373.75252494927;12375.876241237833;7228.554289142087;9228.261739060994;9330.95334523323;9339.813203735752;9430.622775089194;10028.949855250678;10207.846882296622;10259.7435064121;10292.022257885488;10395.740106497398;7239.746608868664;8677.8698319524;8678.349123815613;8713.390062695804;8722.215000649972;8309.667613295642;8499.95750021246;8513.95743021281;8541.572921354033;8663.696770613251;6912.723491060502;7523.7366692165515;7666.540007599562;7770.494917830323;7849.411294152847;5881.147233651011;5907.687388206547;5961.344252132175;5972.432618901197;5988.790392336247;4956.752162391938;5979.073243647242;5979.820605381846;5992.041273396236;6095.9390406097145 20:10:01 INFO - PID 1643 | |4;prototype.html;330.65942079657947;380.8267238406525;394.69016821794895;416.0846138495311;418.2450676528865;4655;5495.642783219093;6193.81418557444;6254.030625253082;6347.587406818554;4851.975740121304;5122.385313762354;6114.401379413754;6222.875542489148;6269.780557680482;3857.864974725885;4540.318952157187;4672.883177920562;4716;4734.502877197896;4106.897327566805;4710.3641008463765;4733.195356789354;4735.171345014626;4748.0978614063215;3841.2893614681234;4678.345031695565;4691.5073917238715;4695.295705644164;4700.741459219742;4526.592606665399;4605.332226827125;4646.837360692393;4660.3941487606735;4694.694844835075;3547.9822600887087;3725.6460636239512;3802.4866643003393;3914.706397020235;3996.500437445319;5351.57127524151;6176.660283684396;6181.412765787243;6186.350433204494;6224.87550248997;4221.493420789494;5133.666311689765;5240.030594340059;5487.478689524489;5515.283013208297;5226.216067589854;5782.306123265193;6599.8020059398295;6679.565828221199;6705.832354191136;4016.5380981187245;4232.365145228209;4464.8883777905485;4484.1928452878465;4484.851512351095;6155.630662160284;6666.033425153374;6717.328267173292;7046.894296585555;7114.537555058904;4168.520620128664;4471.7987690554;4550.863474095782;4553.726776393427;4554.225781617133;3879.903002424962;3937.7637341759587;4622.19111655459;4622.497688251265;4647.814087436464;4700.365450664185;5164.97848758473;5506.174073888948;5533.012173426385;5542.224088627595;6645.269020407752;6732.394084532416;6741.157355330583;6756.391924726799;6787.932120678829;1535;1547.8839087068516;1549.093780138609;1553.9145347005797;1554.0209667909146;983.6704703924122;998.4608311511703;998.9051040151174;1029.5006921642996;1046.8168070587617;5366.570674346043;6298;6342.651154186564;6359.473726305653;6389.083275017476;6813.897791533131;6987.366569383892;7020.613866237304;7021.684024218923;7023.595280943831;5351.785928562814;5781.4218578141845;5848.824535263949;6342.587731797418;6355.396237357444;3639;3649.543807024122;3685.539307586552;3690.6309369063415;3691.3171063353366;5778.162166485836;6035.909461358083;6719.832004199934;6930.757423490154;7155.67799449026;6986.126734158231;7141.535800172972;7159.89260161098;7175.390091842148;7184.748533801397;6319.715612797435;6580.407763301135;6834.769741446587;7101.325374089453;7201.855962880713;6965.860682786417;6971.6862741175755;6977.476689248429;6998.2651821558;7022.894656580258;5644.576656750843;6736.528443008942;6795.572929684821;6904.378605925491;6935.751564718399;5996.67018313997;6713.160854893138;6794.76218332356;6965.199002114821;7230.819229519304;3842.69258459317;3986.5016872890887;4487.192305385062;4496.190685676479;4552.135094332067;5936.228290322403;6359.3640635936035;6673.265940746611;6976.372126508639;7033.613151276729;5620.297462817148;6719.865602688016;6758.290379510081;6777.661116944035;6810.965945170243;6206.286277078194;6521.739130434729;6526.869462610626;6679.766208182885;6744.966275168593;5472.699001554953;5720.7974929651555;6538.280789113099;6632.701528431136;6655.833604159935;6245.96877015612;6766.661666916733;6788.1175447191545;6792.83017924536;6797.1843378794865;5144.459831717765;5459.235707001102;5910.615809972338;6337.415646088478;6405.327440618668 20:10:01 INFO - PID 1643 | |5;yui.html;713.2368365848538;733.9596322202278;737.4395459450819;740.7296336837054;742.7029188324669;15344.846551534481;15562.221888905566;15645.530634080982;15674.843251567481;16083.678326433464;14893.851061489382;15055.698886022274;15062.6987460251;15103.697926041472;15144.167070811101;903.905089965554;928.9535523223846;945.2060269373725;977.6529332087114;985.1035557642547;982.3614650477211;999.8750156230471;1000.7898341348325;1001.8697569315979;1002.6791426743445;1026.8151732688113;1029.2486484866051;1032.0298919016138;1041.8593489878883;1044.9425281609508;1006;1033.9844902326472;1039.9480025998669;1040.5109598488737;1044.4725413666126;753.9208383119803;773.7949443397504;776.6543887969799;777.1567848883967;777.5451360953849;16195.595110122224;16479.176041197894;16523.421680241136;16658.16709164537;16860.578485537837;14471.348789304506;14523.491677791333;14579.416823327054;14600.415983360654;14855.331510081964;11674.883251167465;11711.648650540412;11855.184785086349;11885.599238524264;12148.635540933787;3006.2183832203787;3030.6211723534557;3038.2860027893425;3120.0483852425;3136.341368312634;107619;109049.90950090477;113211;116221.41889290584;116554;8599.828003439896;10368.118709909591;10390.428526430967;11244.943775281072;11378.146639002109;21419.250326238507;24876.751232487444;25045.87477062603;25054.62418063694;25105.874470627896;7779.7666070017995;7847.097583777939;7878.606069696492;7944.483608565425;8050.919490805134;4151.1075118848985;4169.56219596944;4170.436991006236;4171.165766846643;4180.811863466151;3491.6682915123024;4111.198316328288;4132.028973191298;4185.958140418617;4209.7474151551005;799.093029411622;808.5633757770738;826.98346033079;841.6044459104211;858.9785255368665;529.3409704917402;544.3331918400007;568.9829305120853;572.55305262741;582.9387914269025;8800.767892495056;9999.551812916769;10258.846117308247;10433.158365255338;10641.308314959502;508.7100352798943;532.6111938285073;557.3033707865169;579.2296245992903;580.4369761331502;4373.584509471595;4749.976250118796;4783.330333753277;4785.612172470014;4800.807967681323;88483;107532;109663.45168274107;110217.24456888642;111554.44222778997;74659.5068098635;76512.61743691246;77685;80030;82635.58682206551;63870;64516;64899;65778;74259.62870185614;10799.082078023455;10834.02493775564;10840.67477975662;11046.33721976684;11073.280236784583;36678.8166059168;36910;37119.814400927826;37127.6287237135;37527;48196;49372.75313623409;49542;50299.49700503094;50511.74744126256;10302.885286435074;11333.26333788301;13160.736785264433;13664.316784160554;13817.170969741848;11767.76464470723;12150.939245303716;13890.861091388957;14134.78797818013;14142.292885355897;11244.606438774603;11668.066554675435;12585.748285034066;13370.598882033555;13564.321783910962;13178.209307441584;13449.596512104652;13651.59045228605;13660.385282662503;13904.721905562035;13000.739985200433;13057.412416441093;13236.404361803548;13321.533746318832;13701;7385.446091543048;9722.131971068693;9783.8089004583;10220.335678181193;10533.210009249491;7517.774466766005;8763.298936085226;9775.315727899264;11145.164112691742;11253.71865703364 20:10:01 INFO - PID 1643 | __end_tp_report 20:10:01 INFO - PID 1643 | __start_cc_report 20:10:01 INFO - PID 1643 | _x_x_mozilla_cycle_collect,417 20:10:01 INFO - PID 1643 | __end_cc_report 20:10:01 INFO - PID 1643 | __startTimestamp1490497801400__endTimestamp 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | ------- Summary: start ------- 20:10:01 INFO - PID 1643 | Number of tests: 6 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6121.81 Median:6303.50 stddev:701.16 (11.1%) stddev-sans-first:654.79 20:10:01 INFO - PID 1643 | Values: 2854.4 3506.5 3549.8 3568.3 3615.7 6144.0 6207.9 6217.4 6260.4 6276.5 6128.4 6155.9 6201.2 6223.2 6314.4 5283.2 5587.3 5610.0 5613.8 5733.7 5576.5 5669.4 5707.4 5709.6 5796.8 5506.3 5549.7 5594.4 5635.7 5692.5 5552.5 5577.2 5661.7 5687.1 5693.9 5470.9 5496.2 5579.6 5581.0 5613.1 5131.9 6068.8 6193.5 6234.8 6237.5 6378.1 6472.4 6590.4 6633.2 6636.1 6737.1 6765.9 6785.0 6785.0 6792.7 6203.7 6320.3 6354.5 6355.5 6371.1 6628.3 6724.2 6814.6 6831.4 6921.9 5578.5 6138.0 6366.6 6389.5 6526.2 6609.3 6729.3 6732.0 6739.1 6771.9 6337.4 6652.5 6680.2 6708.2 6718.2 6057.8 6413.2 6510.1 6513.3 6614.9 5331.4 5370.8 5379.9 5381.0 5404.6 4751.4 4771.4 4771.8 4793.7 4830.3 6148.6 6170.0 6256.8 6279.5 6286.3 6699.6 6720.6 6735.4 6758.1 6783.4 6270.0 6283.6 6296.2 6303.5 6318.0 5792.8 5903.0 5941.7 5986.8 5987.7 6731.6 6799.1 6851.8 6857.8 6878.3 6739.1 6750.7 6780.5 6781.5 6783.5 6783.1 6815.7 6864.5 6892.9 6917.2 5457.4 6404.7 6406.6 6507.1 6532.9 5567.7 5588.9 6577.1 6728.2 6808.0 6198.3 6371.8 6513.5 6531.8 6548.0 5752.3 6239.8 6300.0 6343.3 6414.1 6135.3 6238.1 6311.7 6316.9 6327.8 6350.3 6403.7 6408.7 6437.4 6459.2 5636.8 6047.8 6356.4 6387.2 6396.8 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:52347.30 Median:359426.10 stddev:104452.81 (29.1%) stddev-sans-first:104673.99 20:10:01 INFO - PID 1643 | Values: 752.6 806.4 831.4 1167.7 1290.8 37534.2 38308.4 38531.4 38594.4 38684.0 37847.8 38234.0 38254.4 38348.8 38489.8 8137.8 8235.1 8510.8 8721.7 8772.6 8646.7 8738.5 8781.2 8784.5 8810.0 8745.1 8797.5 8806.5 8817.8 8818.7 8113.6 8460.0 8794.3 8903.6 8927.6 8586.8 8602.0 8670.3 8679.6 8701.5 36351.0 38002.8 38615.0 38797.0 38896.2 2630.5 3044.5 3066.8 3091.8 3106.3 27471.3 27747.7 27800.4 27841.0 28566.0 2823.6 2828.8 2834.3 2844.2 2910.9 340130.0 342486.0 342941.0 343705.3 344086.0 49434.8 49698.0 49702.0 49816.5 49905.3 52044.7 52382.5 52499.2 52516.9 52642.7 14386.6 14492.9 14559.7 14582.9 14595.9 9736.9 11776.0 11799.7 11799.9 11802.4 11633.8 12041.0 13587.5 13590.7 13647.9 5416.5 5891.8 5904.9 5908.3 5945.8 887.5 989.9 993.1 997.7 1021.6 20563.8 24247.9 24372.6 24515.5 24518.4 839.5 911.5 1076.7 1110.9 1127.6 11847.9 12312.1 12464.4 12487.9 12509.9 465726.0 468508.0 469192.0 469591.0 470170.0 51819.0 53711.1 54690.2 55159.0 55442.6 1193.9 1461.4 1471.9 1510.0 1524.7 19074.6 27527.3 28619.3 29018.9 29363.9 37781.2 37973.0 37983.2 37990.6 37993.6 354272.0 357181.0 358894.0 359080.0 359772.2 31053.9 31461.2 31729.5 32200.4 32208.0 41444.0 41567.0 41573.6 41617.8 42117.4 23415.4 27612.4 28105.6 28146.0 29174.6 29723.9 29765.0 30410.2 30663.0 30686.1 32902.3 34626.5 36388.6 36615.6 36729.1 23835.0 28011.6 29008.7 29661.6 30009.7 22200.3 23171.4 23177.0 23689.1 23718.0 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:38515.24 Median:2168.76 stddev:108969.81 (5024.5%) stddev-sans-first:109237.89 20:10:01 INFO - PID 1643 | Values: 384.9 417.8 432.4 442.5 447.5 18980.9 20521.6 21416.4 21554.6 21633.7 17322.8 17974.6 20920.1 22425.8 22668.3 6091.2 6318.9 6360.3 6364.4 6374.0 5866.8 6096.7 6160.2 6195.5 6332.7 6108.5 6120.5 6121.1 6124.9 6133.3 6082.9 6087.0 6101.5 6174.4 6186.6 4616.3 5375.4 5406.3 5442.7 5449.7 26190.6 26401.3 26918.7 27523.0 27791.4 2027.8 2051.7 2052.1 2054.4 2091.0 15192.7 15704.5 15720.8 16116.0 16720.0 1637.4 1656.6 1657.4 1681.1 1709.4 128672.0 132122.3 141662.0 162571.0 177282.0 11952.9 12035.5 12191.8 12336.3 12508.7 15739.2 15778.6 15804.2 15821.9 15823.5 8764.1 8994.4 9089.8 9182.6 9221.4 8804.9 8809.0 8821.2 8983.2 9002.7 7602.8 7738.7 7785.3 7806.8 7819.6 2060.1 2157.7 2168.5 2169.1 2317.7 749.6 858.6 927.1 928.4 933.7 19752.0 20147.2 20401.8 20461.9 20542.7 865.8 969.0 981.0 1003.3 1014.7 7653.5 9937.2 10524.5 10593.0 10837.0 398205.0 569992.4 719746.0 730398.9 733246.0 157648.0 160260.0 161053.2 162026.0 165530.0 1023.5 1156.2 1186.8 1201.5 1203.7 17540.8 17695.6 17750.6 17778.8 18014.0 62261.0 62881.0 63591.0 63676.0 63856.4 83771.0 84115.0 84665.0 84762.0 90370.1 8088.8 8148.7 8172.5 8557.7 8609.7 10772.3 12266.5 12373.8 12730.0 13062.3 11035.8 11202.8 11276.3 11389.3 11449.8 10422.0 10508.6 10655.6 10662.7 10857.1 10523.5 11091.9 11457.4 11540.3 11642.9 7206.9 8072.1 8093.1 8167.1 8471.2 10681.4 10706.7 11277.9 11532.1 11614.7 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:6704.59 Median:2445.38 stddev:4165.50 (170.3%) stddev-sans-first:4156.40 20:10:01 INFO - PID 1643 | Values: 1166.9 1408.3 1422.1 1430.4 1441.0 10440.8 10837.2 10861.4 10895.3 11125.0 10663.7 11031.7 11136.2 11140.8 11154.4 2393.3 2422.9 2432.2 2432.5 2442.8 2352.5 2433.3 2450.9 2451.2 2454.6 2371.8 2434.6 2437.3 2439.3 2442.3 1975.0 2051.1 2412.7 2419.5 2447.9 2035.3 2373.8 2419.0 2428.2 2436.8 10860.2 10931.5 10972.4 10978.1 10979.0 6145.4 6381.6 6385.9 6419.0 6463.3 3968.1 4021.0 4062.5 4084.6 4100.7 1168.8 1172.9 1197.4 1220.8 1229.2 13660.0 14134.4 15172.8 15339.7 15372.1 5206.3 5316.4 5464.3 5493.6 5513.1 11229.6 11282.8 11302.7 11328.2 11335.3 5212.4 5512.4 6290.3 6301.1 6309.7 4845.0 5448.2 5816.8 6012.9 6039.8 4240.7 4300.0 4301.3 4312.4 4368.6 1252.8 1265.2 1269.9 1277.2 1287.1 760.8 779.5 785.2 786.7 796.4 5220.7 5281.8 5499.6 5965.6 6100.8 567.2 579.2 584.6 588.2 600.4 3087.9 4137.0 4151.0 4158.2 4259.6 13295.4 13786.2 13910.9 13929.9 13984.0 13068.5 13690.9 13768.4 13826.3 13826.4 10146.3 10371.8 10387.1 10392.3 10410.5 5667.0 6654.2 6751.5 6795.6 6862.1 12009.3 12255.9 12291.9 12337.0 12445.8 12092.5 12262.9 12320.1 12373.8 12375.9 7228.6 9228.3 9331.0 9339.8 9430.6 10028.9 10207.8 10259.7 10292.0 10395.7 7239.7 8677.9 8678.3 8713.4 8722.2 8309.7 8500.0 8514.0 8541.6 8663.7 6912.7 7523.7 7666.5 7770.5 7849.4 5881.1 5907.7 5961.3 5972.4 5988.8 4956.8 5979.1 5979.8 5992.0 6095.9 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5332.01 Median:5923.42 stddev:1695.47 (28.6%) stddev-sans-first:1658.15 20:10:01 INFO - PID 1643 | Values: 330.7 380.8 394.7 416.1 418.2 4655.0 5495.6 6193.8 6254.0 6347.6 4852.0 5122.4 6114.4 6222.9 6269.8 3857.9 4540.3 4672.9 4716.0 4734.5 4106.9 4710.4 4733.2 4735.2 4748.1 3841.3 4678.3 4691.5 4695.3 4700.7 4526.6 4605.3 4646.8 4660.4 4694.7 3548.0 3725.6 3802.5 3914.7 3996.5 5351.6 6176.7 6181.4 6186.4 6224.9 4221.5 5133.7 5240.0 5487.5 5515.3 5226.2 5782.3 6599.8 6679.6 6705.8 4016.5 4232.4 4464.9 4484.2 4484.9 6155.6 6666.0 6717.3 7046.9 7114.5 4168.5 4471.8 4550.9 4553.7 4554.2 3879.9 3937.8 4622.2 4622.5 4647.8 4700.4 5165.0 5506.2 5533.0 5542.2 6645.3 6732.4 6741.2 6756.4 6787.9 1535.0 1547.9 1549.1 1553.9 1554.0 983.7 998.5 998.9 1029.5 1046.8 5366.6 6298.0 6342.7 6359.5 6389.1 6813.9 6987.4 7020.6 7021.7 7023.6 5351.8 5781.4 5848.8 6342.6 6355.4 3639.0 3649.5 3685.5 3690.6 3691.3 5778.2 6035.9 6719.8 6930.8 7155.7 6986.1 7141.5 7159.9 7175.4 7184.7 6319.7 6580.4 6834.8 7101.3 7201.9 6965.9 6971.7 6977.5 6998.3 7022.9 5644.6 6736.5 6795.6 6904.4 6935.8 5996.7 6713.2 6794.8 6965.2 7230.8 3842.7 3986.5 4487.2 4496.2 4552.1 5936.2 6359.4 6673.3 6976.4 7033.6 5620.3 6719.9 6758.3 6777.7 6811.0 6206.3 6521.7 6526.9 6679.8 6745.0 5472.7 5720.8 6538.3 6632.7 6655.8 6246.0 6766.7 6788.1 6792.8 6797.2 5144.5 5459.2 5910.6 6337.4 6405.3 20:10:01 INFO - PID 1643 | 20:10:01 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:19292.71 Median:25050.25 stddev:28018.57 (111.8%) stddev-sans-first:28062.44 20:10:01 INFO - PID 1643 | Values: 713.2 734.0 737.4 740.7 742.7 15344.8 15562.2 15645.5 15674.8 16083.7 14893.9 15055.7 15062.7 15103.7 15144.2 903.9 929.0 945.2 977.7 985.1 982.4 999.9 1000.8 1001.9 1002.7 1026.8 1029.2 1032.0 1041.9 1044.9 1006.0 1034.0 1039.9 1040.5 1044.5 753.9 773.8 776.7 777.2 777.5 16195.6 16479.2 16523.4 16658.2 16860.6 14471.3 14523.5 14579.4 14600.4 14855.3 11674.9 11711.6 11855.2 11885.6 12148.6 3006.2 3030.6 3038.3 3120.0 3136.3 107619.0 109049.9 113211.0 116221.4 116554.0 8599.8 10368.1 10390.4 11244.9 11378.1 21419.3 24876.8 25045.9 25054.6 25105.9 7779.8 7847.1 7878.6 7944.5 8050.9 4151.1 4169.6 4170.4 4171.2 4180.8 3491.7 4111.2 4132.0 4186.0 4209.7 799.1 808.6 827.0 841.6 859.0 529.3 544.3 569.0 572.6 582.9 8800.8 9999.6 10258.8 10433.2 10641.3 508.7 532.6 557.3 579.2 580.4 4373.6 4750.0 4783.3 4785.6 4800.8 88483.0 107532.0 109663.5 110217.2 111554.4 74659.5 76512.6 77685.0 80030.0 82635.6 63870.0 64516.0 64899.0 65778.0 74259.6 10799.1 10834.0 10840.7 11046.3 11073.3 36678.8 36910.0 37119.8 37127.6 37527.0 48196.0 49372.8 49542.0 50299.5 50511.7 10302.9 11333.3 13160.7 13664.3 13817.2 11767.8 12150.9 13890.9 14134.8 14142.3 11244.6 11668.1 12585.7 13370.6 13564.3 13178.2 13449.6 13651.6 13660.4 13904.7 13000.7 13057.4 13236.4 13321.5 13701.0 7385.4 9722.1 9783.8 10220.3 10533.2 7517.8 8763.3 9775.3 11145.2 11253.7 20:10:01 INFO - PID 1643 | -------- Summary: end -------- 20:10:01 INFO - PID 1643 | 20:10:02 INFO - TEST-INFO | 1643: exit 0 20:10:02 INFO - TEST-OK | dromaeo_css | took 1117156ms 20:10:02 INFO - TEST-START | kraken 20:10:02 INFO - operating with platform_type : mac_ 20:10:02 INFO - Initialising browser for kraken test... 20:10:02 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpN6bFnl/profile http://localhost:49243/getInfo.html) 20:10:04 INFO - PID 1654 | 2017-03-25 20:10:04.954 plugin-container[1655:11388] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 20:10:04 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:04 INFO - PID 1654 | 2017-03-25 20:10:04.957 plugin-container[1655:11388] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 20:10:04 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:04 INFO - PID 1654 | 2017-03-25 20:10:04.957 plugin-container[1655:11388] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:10:05 INFO - PID 1654 | __metrics Screen width/height:1600/1200 20:10:05 INFO - PID 1654 | colorDepth:24 20:10:05 INFO - PID 1654 | Browser inner width/height: 1024/689 20:10:05 INFO - PID 1654 | __metrics 20:10:05 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 20:10:05 ERROR - PID 1654 | 1490497805108 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < forceQuit@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpN6bFnl/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpN6bFnl/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpN6bFnl/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpN6bFnl/profile/extensions/talos-powers@TalosPowersService.js:55:9 20:10:05 INFO - TEST-INFO | 1654: exit 0 20:10:05 INFO - Browser initialized. 20:10:05 INFO - Running cycle 1/1 for kraken test... 20:10:05 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpN6bFnl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:08 INFO - PID 1656 | 2017-03-25 20:10:08.245 plugin-container[1657:11508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 20:10:08 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:08 INFO - PID 1656 | 2017-03-25 20:10:08.247 plugin-container[1657:11508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 20:10:08 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:08 INFO - PID 1656 | 2017-03-25 20:10:08.247 plugin-container[1657:11508] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:10:17 INFO - PID 1656 | RSS: Main: 228241408 20:10:17 INFO - PID 1656 | 20:10:20 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 20:10:21 INFO - PID 1656 | RSS: Main: 242122752 20:10:21 INFO - PID 1656 | 20:10:24 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 20:10:25 INFO - PID 1656 | RSS: Main: 250679296 20:10:25 INFO - PID 1656 | 20:10:28 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 20:10:29 INFO - PID 1656 | RSS: Main: 253431808 20:10:29 INFO - PID 1656 | 20:10:31 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 20:10:31 INFO - PID 1656 | RSS: Main: 255627264 20:10:31 INFO - PID 1656 | 20:10:33 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:10:34 INFO - PID 1656 | RSS: Main: 256049152 20:10:34 INFO - PID 1656 | 20:10:37 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 20:10:38 INFO - PID 1656 | RSS: Main: 261529600 20:10:38 INFO - PID 1656 | 20:10:41 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 20:10:41 INFO - PID 1656 | RSS: Main: 261926912 20:10:41 INFO - PID 1656 | 20:10:45 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 20:10:45 INFO - PID 1656 | RSS: Main: 261844992 20:10:45 INFO - PID 1656 | 20:10:47 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:10:48 INFO - PID 1656 | RSS: Main: 261767168 20:10:48 INFO - PID 1656 | 20:10:49 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:10:50 INFO - PID 1656 | RSS: Main: 261758976 20:10:50 INFO - PID 1656 | 20:10:52 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:10:53 INFO - PID 1656 | RSS: Main: 261771264 20:10:53 INFO - PID 1656 | 20:10:56 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:10:57 INFO - PID 1656 | RSS: Main: 262160384 20:10:57 INFO - PID 1656 | 20:11:00 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:01 INFO - PID 1656 | RSS: Main: 259571712 20:11:01 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 20:11:03 INFO - PID 1656 | RSS: Main: 262557696 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | __start_tp_report 20:11:03 INFO - PID 1656 | _x_x_mozilla_page_load 20:11:03 INFO - PID 1656 | _x_x_mozilla_page_load_details 20:11:03 INFO - PID 1656 | |i|pagename|runs| 20:11:03 INFO - PID 1656 | |0;ai-astar;134;171;147;117;116;118;116;131;161;155 20:11:03 INFO - PID 1656 | |1;audio-beat-detection;147;116;114;155;112;120;158;119;139;116 20:11:03 INFO - PID 1656 | |2;audio-dft;199;211;216;223;208;198;203;233;250;200 20:11:03 INFO - PID 1656 | |3;audio-fft;80;56;57;89;55;68;69;85;96;57 20:11:03 INFO - PID 1656 | |4;audio-oscillator;90;73;85;64;104;72;122;89;69;82 20:11:03 INFO - PID 1656 | |5;imaging-gaussian-blur;88;107;88;89;131;137;136;88;89;89 20:11:03 INFO - PID 1656 | |6;imaging-darkroom;95;100;97;95;96;99;97;105;119;98 20:11:03 INFO - PID 1656 | |7;imaging-desaturate;109;90;90;97;92;92;96;93;130;147 20:11:03 INFO - PID 1656 | |8;json-parse-financial;70;66;65;66;87;102;101;92;84;67 20:11:03 INFO - PID 1656 | |9;json-stringify-tinderbox;65;61;62;67;64;64;60;59;59;62 20:11:03 INFO - PID 1656 | |10;stanford-crypto-aes;81;82;82;73;85;109;84;84;84;83 20:11:03 INFO - PID 1656 | |11;stanford-crypto-ccm;156;157;150;133;146;156;154;155;273;157 20:11:03 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;189;243;243;243;233;190;185;186;192;170 20:11:03 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;70;70;69;68;70;67;70;68;67;68 20:11:03 INFO - PID 1656 | __end_tp_report 20:11:03 INFO - PID 1656 | __start_cc_report 20:11:03 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1011 20:11:03 INFO - PID 1656 | __end_cc_report 20:11:03 INFO - PID 1656 | __startTimestamp1490497863306__endTimestamp 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | ------- Summary: start ------- 20:11:03 INFO - PID 1656 | Number of tests: 14 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:136.60 Median:140.50 stddev:20.66 (14.7%) stddev-sans-first:21.89 20:11:03 INFO - PID 1656 | Values: 134.0 171.0 147.0 117.0 116.0 118.0 116.0 131.0 161.0 155.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:129.50 stddev:18.17 (14.0%) stddev-sans-first:18.15 20:11:03 INFO - PID 1656 | Values: 147.0 116.0 114.0 155.0 112.0 120.0 158.0 119.0 139.0 116.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:214.10 Median:213.50 stddev:16.95 (7.9%) stddev-sans-first:17.07 20:11:03 INFO - PID 1656 | Values: 199.0 211.0 216.0 223.0 208.0 198.0 203.0 233.0 250.0 200.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:71.20 Median:74.50 stddev:15.32 (20.6%) stddev-sans-first:15.91 20:11:03 INFO - PID 1656 | Values: 80.0 56.0 57.0 89.0 55.0 68.0 69.0 85.0 96.0 57.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:77.50 stddev:17.61 (22.7%) stddev-sans-first:18.58 20:11:03 INFO - PID 1656 | Values: 90.0 73.0 85.0 64.0 104.0 72.0 122.0 89.0 69.0 82.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:104.20 Median:88.00 stddev:21.84 (24.8%) stddev-sans-first:22.37 20:11:03 INFO - PID 1656 | Values: 88.0 107.0 88.0 89.0 131.0 137.0 136.0 88.0 89.0 89.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:96.50 stddev:7.26 (7.5%) stddev-sans-first:7.47 20:11:03 INFO - PID 1656 | Values: 95.0 100.0 97.0 95.0 96.0 99.0 97.0 105.0 119.0 98.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:103.60 Median:92.00 stddev:19.61 (21.3%) stddev-sans-first:20.71 20:11:03 INFO - PID 1656 | Values: 109.0 90.0 90.0 97.0 92.0 92.0 96.0 93.0 130.0 147.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:80.00 Median:68.50 stddev:14.98 (21.9%) stddev-sans-first:15.45 20:11:03 INFO - PID 1656 | Values: 70.0 66.0 65.0 66.0 87.0 102.0 101.0 92.0 84.0 67.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:63.00 stddev:2.67 (4.2%) stddev-sans-first:2.65 20:11:03 INFO - PID 1656 | Values: 65.0 61.0 62.0 67.0 64.0 64.0 60.0 59.0 59.0 62.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.50 stddev:9.19 (11.0%) stddev-sans-first:9.65 20:11:03 INFO - PID 1656 | Values: 81.0 82.0 82.0 73.0 85.0 109.0 84.0 84.0 84.0 83.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:163.70 Median:156.00 stddev:39.11 (25.1%) stddev-sans-first:41.39 20:11:03 INFO - PID 1656 | Values: 156.0 157.0 150.0 133.0 146.0 156.0 154.0 155.0 273.0 157.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.40 Median:212.50 stddev:29.24 (13.8%) stddev-sans-first:30.25 20:11:03 INFO - PID 1656 | Values: 189.0 243.0 243.0 243.0 233.0 190.0 185.0 186.0 192.0 170.0 20:11:03 INFO - PID 1656 | 20:11:03 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.25 (1.8%) stddev-sans-first:1.24 20:11:03 INFO - PID 1656 | Values: 70.0 70.0 69.0 68.0 70.0 67.0 70.0 68.0 67.0 68.0 20:11:03 INFO - PID 1656 | -------- Summary: end -------- 20:11:03 INFO - PID 1656 | 20:11:04 INFO - TEST-INFO | 1656: exit 0 20:11:04 INFO - TEST-OK | kraken | took 62132ms 20:11:04 INFO - SUITE-END | took 1179s 20:11:04 INFO - Completed test suite (00:19:39) 20:11:04 INFO - javascript benchmark 20:11:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7620.513045806909, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2854.3577695018625, 3506.5266189064487, 3549.840257188426, 3568.286342731454, 3615.6926661233792, 6143.969280153593, 6207.906881396777, 6217.440430361272, 6260.436560709535, 6276.529260305472, 6128.442013630949, 6155.8768824623485, 6201.193844800181, 6223.190985171933, 6314.431701146896, 5283.154695248761, 5587.3015873015875, 5609.971950140243, 5613.775448982035, 5733.655980641154, 5576.470235327637, 5669.433056694339, 5707.3721890592005, 5709.571782116337, 5796.797112101077, 5506.284183056177, 5549.667019978774, 5594.356648985378, 5635.718214089279, 5692.459216374438, 5552.500274975271, 5577.2191893135, 5661.745221465003, 5687.0900655895275, 5693.914591281134, 5470.878469913659, 5496.203050557647, 5579.581531385163, 5580.972095139498, 5613.129964855454, 5131.870988382587, 6068.848278793022, 6193.473554747852, 6234.750609975596, 6237.469815065725, 6378.138951241615, 6472.385123413268, 6590.439812615886, 6633.237177724575, 6636.070950066995, 6737.124173857416, 6765.898511522331, 6784.966075169642, 6785.0, 6792.728290868359, 6203.720832562545, 6320.304766475684, 6354.491640668782, 6355.459785918202, 6371.139896113966, 6628.304028077079, 6724.159480064992, 6814.62519561419, 6831.351021652935, 6921.93078069223, 5578.525825304894, 6138.0, 6366.554341196072, 6389.488840892717, 6526.184226971629, 6609.339066093448, 6729.327067293231, 6732.0, 6739.123913891162, 6771.932280677229, 6337.366263373626, 6652.467802575782, 6680.164979377578, 6708.228553716288, 6718.22740384862, 6057.7879774207695, 6413.230412350548, 6510.056041873901, 6513.250976137805, 6614.933850661432, 5331.44019877915, 5370.838874833761, 5379.892402152013, 5381.0, 5404.567634589223, 4751.358566593535, 4771.355866957916, 4771.785269662873, 4793.712377257376, 4830.275458681226, 6148.616561273678, 6170.012797952306, 6256.7810126645345, 6279.497640188774, 6286.339934306923, 6699.631520266432, 6720.563163394364, 6735.393814556714, 6758.121444212221, 6783.38949494538, 6269.968650156811, 6283.59156654816, 6296.244450665949, 6303.495720342362, 6317.9684101580115, 5792.768289268466, 5902.970485147547, 5941.70291485424, 5986.820395388146, 5987.730552125077, 6731.596104233761, 6799.082123913407, 6851.760188393382, 6857.759978400732, 6878.312168783082, 6739.056532085414, 6750.729970801113, 6780.525363224724, 6781.491388145811, 6783.525153239423, 6783.050372947692, 6815.727370905307, 6864.485163612849, 6892.931070689429, 6917.23910369869, 5457.372402173642, 6404.71178796946, 6406.5515413920575, 6507.089007538853, 6532.9346706534225, 5567.721613919207, 5588.86027849307, 6577.14497115372, 6728.226253980659, 6807.965960170168, 6198.264883794998, 6371.776987805404, 6513.511486638616, 6531.771388001397, 6547.9672601636685, 5752.252207213036, 6239.844003899939, 6300.0, 6343.270523889812, 6414.069959855888, 6135.294441139147, 6238.126662267196, 6311.652859092794, 6316.905246421399, 6327.810165695037, 6350.301466838737, 6403.679816009274, 6408.711607977559, 6437.356264373525, 6459.160309159967, 5636.8162685834795, 6047.818565443044, 6356.396142366468, 6387.233531976192, 6396.808095757135], "value": 6076.345888391205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.567273817555, 806.4274365200707, 831.3847752663028, 1167.702235929839, 1290.8321918150646, 37534.249315013716, 38308.425373619386, 38531.42202866959, 38594.421083683694, 38684.03289917753, 37847.810760946224, 38234.0, 38254.42618360727, 38348.808255958684, 38489.80755096228, 8137.75586732396, 8235.052968908562, 8510.78723031926, 8721.694740684077, 8772.56137193141, 8646.740597782045, 8738.519381434018, 8781.209691127797, 8784.472931624123, 8809.955950220272, 8745.125487451267, 8797.47215167092, 8806.471611703286, 8817.823643527126, 8818.735437936872, 8113.553754543498, 8460.0, 8794.252488538483, 8903.643854245822, 8927.553622318857, 8586.78533036679, 8602.0, 8670.263027642657, 8679.566021698953, 8701.47791132534, 36351.0, 38002.80998595017, 38615.03462413434, 38797.0, 38896.22207555833, 2630.487055024271, 3044.528098144791, 3066.8313242771637, 3091.845407729627, 3106.301082256497, 27471.313217169532, 27747.72252277492, 27800.443991120268, 27841.0, 28566.00018999325, 2823.6344251320284, 2828.8444135572536, 2834.3339315260896, 2844.2036229855676, 2910.8690108945148, 340130.0, 342486.0, 342941.0, 343705.28147359355, 344086.0, 49434.752826236356, 49698.0, 49702.0, 49816.50183498119, 49905.25331613376, 52044.73977630088, 52382.476175238524, 52499.21251181235, 52516.94966100657, 52642.73678631582, 14386.568402947929, 14492.927535362256, 14559.708805823824, 14582.854171458363, 14595.854041459663, 9736.853947190797, 11776.0, 11799.705007374885, 11799.88200118005, 11802.350870702194, 11633.825492617618, 12041.0, 13587.52443664467, 13590.660233494043, 13647.931760341135, 5416.512513873691, 5891.7937872175125, 5904.881902362014, 5908.261467316585, 5945.821625351246, 887.4985633117268, 989.851522271665, 993.1161266472845, 997.7256254529917, 1021.596469394585, 20563.794362056487, 24247.908844102058, 24372.634410483857, 24515.509689806462, 24518.387040323778, 839.5256679975917, 911.521451238092, 1076.6985244131656, 1110.9222354435112, 1127.5546159267044, 11847.881521184678, 12312.13815032939, 12464.376781160905, 12487.875121248671, 12509.874901251053, 465726.0, 468508.0, 469192.0, 469591.0, 470170.0, 51819.0, 53711.12011079671, 54690.179647305325, 55159.0, 55442.61393465115, 1193.9044876409866, 1461.3935216884875, 1471.8601732835364, 1510.01848798282, 1524.687439074987, 19074.618507630046, 27527.31181720473, 28619.28451788722, 29018.854905725337, 29363.85318073396, 37781.244375112896, 37973.0, 37983.240335193696, 37990.62009379871, 37993.62006379901, 354272.0, 357181.0, 358894.0, 359080.0, 359772.2011389926, 31053.913113040937, 31461.213469663442, 31729.5240571387, 32200.35599288048, 32208.0, 41444.0, 41567.0, 41573.58426415697, 41617.79191104025, 42117.368239477044, 23415.41461463477, 27612.447751045267, 28105.57841632418, 28146.0, 29174.56238156387, 29723.85138074296, 29765.0, 30410.239744006576, 30663.0, 30686.079417617508, 32902.34195316128, 34626.48060279048, 36388.636113638524, 36615.63384366122, 36729.14343993842, 23835.0, 28011.57982630303, 29008.709912900602, 29661.5550766743, 30009.699903000692, 22200.333989980325, 23171.420714482272, 23177.0, 23689.05243790229, 23718.0], "value": 17585.754430598106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.94803201567817, 417.75959571652027, 432.38817073840517, 442.47566633539253, 447.5144468251946, 18980.905095474536, 20521.589568208627, 21416.35750927471, 21554.56890862182, 21633.67549486757, 17322.826771732278, 17974.5506362341, 20920.101679708925, 22425.766582837936, 22668.319950401514, 6091.238595175603, 6318.905216421735, 6360.332165122665, 6364.395382438661, 6373.968130159343, 5866.76532938682, 6096.725647345858, 6160.1683772690785, 6195.504359651217, 6332.683365831713, 6108.541859360544, 6120.540959428038, 6121.112438696387, 6124.908126378085, 6133.264008319008, 6082.9391706082815, 6086.969565152168, 6101.511879049665, 6174.444300012976, 6186.628802271878, 4616.28447590624, 5375.354957405137, 5406.270153529263, 5442.700651464168, 5449.700266485342, 26190.607140892902, 26401.3399665008, 26918.654067296753, 27523.036693715625, 27791.444171116666, 2027.8377729781582, 2051.661475856482, 2052.0868213644935, 2054.4042227753935, 2091.0381224636685, 15192.696146077127, 15704.450344237897, 15720.764188537181, 16116.0, 16720.0, 1637.3859802574034, 1656.6355401811702, 1657.4199030339405, 1681.0838093239213, 1709.384621536246, 128672.0, 132122.3393883034, 141662.0, 162571.0, 177282.0, 11952.940235298767, 12035.458404371824, 12191.817122743167, 12336.32150231728, 12508.74982500345, 15739.213039347987, 15778.605534861721, 15804.209789510709, 15821.892467527163, 15823.525294241192, 8764.079771623889, 8994.415363001384, 9089.77275568116, 9182.586783594754, 9221.446713197229, 8804.8679269811, 8809.0, 8821.2060914518, 8983.191512763751, 9002.684906028258, 7602.8099297518, 7738.690452381842, 7785.299323060838, 7806.804829879185, 7819.648115834687, 2060.11499477976, 2157.676348547699, 2168.4578855286177, 2169.0564604396823, 2317.7450480447137, 749.6326799868134, 858.626497473601, 927.1284992107397, 928.3919033033374, 933.7058826469777, 19752.0, 20147.19411223564, 20401.795982040287, 20461.89769051145, 20542.69185962212, 865.7835541114721, 968.970930872075, 980.960182206863, 1003.2826529031631, 1014.700663304327, 7653.502522336031, 9937.205023598095, 10524.473776311153, 10592.96432227302, 10837.0, 398205.0, 569992.3503442272, 719746.0, 730398.8720789494, 733246.0, 157648.02343777323, 160260.0, 161053.19473402793, 162026.0, 165530.0, 1023.4933707814531, 1156.1700295573266, 1186.7507823357191, 1201.4953719437858, 1203.6990752311922, 17540.82459175443, 17695.646087078443, 17750.556236094202, 17778.822211778235, 18014.0, 62261.0, 62881.0, 63591.0, 63676.044859328074, 63856.36143638504, 83771.0, 84115.0, 84665.0, 84762.0, 90370.09629903617, 8088.8271200676745, 8148.714794982147, 8172.509649421054, 8557.657693692183, 8609.65561377538, 10772.299800512941, 12266.509339626671, 12373.75252494927, 12730.0, 13062.34688265602, 11035.83446248323, 11202.831957520806, 11276.26704264253, 11389.316641001566, 11449.828252576051, 10422.0, 10508.632197873038, 10655.602489439814, 10662.680119596425, 10857.077148442471, 10523.473826308807, 11091.889081109086, 11457.427128643702, 11540.307581545134, 11642.941785291358, 7206.918962155509, 8072.112067672669, 8093.069297030681, 8167.101618822044, 8471.237588617054, 10681.412522311037, 10706.678799636024, 11277.887221128012, 11532.077433805443, 11614.70963225926], "value": 10171.677985884566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1166.9241499302545, 1408.267700795587, 1422.0898624880072, 1430.3992323224245, 1441.020106327697, 10440.791184176313, 10837.241393102486, 10861.40262285574, 10895.346279223242, 11125.0, 10663.733406664836, 11031.669049928494, 11136.164787640919, 11140.777184456327, 11154.386508742016, 2393.32986763706, 2422.8667423291713, 2432.20953190213, 2432.5378178146098, 2442.8167887408426, 2352.541254455382, 2433.2700189943034, 2450.8529488230674, 2451.240115564172, 2454.607262837946, 2371.833971621987, 2434.6104623260194, 2437.2931849763636, 2439.329184474275, 2442.2917353967327, 1974.9802501974941, 2051.1180192517213, 2412.6622272881723, 2419.52819200256, 2447.938801529967, 2035.3283416472677, 2373.7982271506944, 2419.0444774314046, 2428.1986944308337, 2436.768506991833, 10860.239783215178, 10931.508082136243, 10972.396518191495, 10978.066864316543, 10978.956999085074, 6145.4161854623735, 6381.617102973836, 6385.872282554323, 6418.967905160444, 6463.256725476584, 3968.0873399118077, 4020.9746514638873, 4062.4921884764403, 4084.611961863618, 4100.712950093465, 1168.772089442559, 1172.9003034742057, 1197.4312201704208, 1220.7680540697238, 1229.2071613809132, 13660.0, 14134.36395362211, 15172.848271517365, 15339.693206135926, 15372.077675339515, 5206.323177986837, 5316.415194328621, 5464.3442786865035, 5493.642913210709, 5513.145462453326, 11229.606963756229, 11282.830757538644, 11302.717432064099, 11328.150388720878, 11335.263207891461, 5212.40057393397, 5512.4211957744665, 6290.276618188876, 6301.117843501914, 6309.716062777186, 4845.013544446831, 5448.182772584065, 5816.82549523515, 6012.939870601325, 6039.818805435844, 4240.660747140221, 4299.97850010748, 4301.333293339538, 4312.37470566766, 4368.60682538573, 1252.7557126360273, 1265.1776345375395, 1269.9262431596464, 1277.1826031339765, 1287.060445874498, 760.81360066784, 779.5050143159021, 785.1520358013332, 786.7167819584945, 796.3987189671876, 5220.712860792617, 5281.815136470205, 5499.5976026113085, 5965.642061476326, 6100.847478812976, 567.222904620664, 579.2469789274011, 584.5732615190849, 588.1706793421341, 600.3726106219011, 3087.9382412352074, 4136.958630413717, 4151.0, 4158.189153115113, 4259.61663450291, 13295.401706923212, 13786.172829630254, 13910.930445347709, 13929.930350348184, 13984.0, 13068.477260909647, 13690.863091369158, 13768.449262029608, 13826.308684565933, 13826.377812998438, 10146.340487868265, 10371.844422333672, 10387.065164135112, 10392.324498907547, 10410.47947602632, 5667.0, 6654.201495820533, 6751.45988320943, 6795.59226446395, 6862.073620061228, 12009.279443233434, 12255.877441225473, 12291.938540307241, 12337.0, 12445.813312800134, 12092.516299348279, 12262.87737122653, 12320.130949133278, 12373.75252494927, 12375.876241237833, 7228.554289142087, 9228.261739060994, 9330.95334523323, 9339.813203735752, 9430.622775089194, 10028.949855250678, 10207.846882296622, 10259.7435064121, 10292.022257885488, 10395.740106497398, 7239.746608868664, 8677.8698319524, 8678.349123815613, 8713.390062695804, 8722.215000649972, 8309.667613295642, 8499.95750021246, 8513.95743021281, 8541.572921354033, 8663.696770613251, 6912.723491060502, 7523.7366692165515, 7666.540007599562, 7770.494917830323, 7849.411294152847, 5881.147233651011, 5907.687388206547, 5961.344252132175, 5972.432618901197, 5988.790392336247, 4956.752162391938, 5979.073243647242, 5979.820605381846, 5992.041273396236, 6095.9390406097145], "value": 5062.17613447424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.65942079657947, 380.8267238406525, 394.69016821794895, 416.0846138495311, 418.2450676528865, 4655.0, 5495.642783219093, 6193.81418557444, 6254.030625253082, 6347.587406818554, 4851.975740121304, 5122.385313762354, 6114.401379413754, 6222.875542489148, 6269.780557680482, 3857.864974725885, 4540.318952157187, 4672.883177920562, 4716.0, 4734.502877197896, 4106.897327566805, 4710.3641008463765, 4733.195356789354, 4735.171345014626, 4748.0978614063215, 3841.2893614681234, 4678.345031695565, 4691.5073917238715, 4695.295705644164, 4700.741459219742, 4526.592606665399, 4605.332226827125, 4646.837360692393, 4660.3941487606735, 4694.694844835075, 3547.9822600887087, 3725.6460636239512, 3802.4866643003393, 3914.706397020235, 3996.500437445319, 5351.57127524151, 6176.660283684396, 6181.412765787243, 6186.350433204494, 6224.87550248997, 4221.493420789494, 5133.666311689765, 5240.030594340059, 5487.478689524489, 5515.283013208297, 5226.216067589854, 5782.306123265193, 6599.8020059398295, 6679.565828221199, 6705.832354191136, 4016.5380981187245, 4232.365145228209, 4464.8883777905485, 4484.1928452878465, 4484.851512351095, 6155.630662160284, 6666.033425153374, 6717.328267173292, 7046.894296585555, 7114.537555058904, 4168.520620128664, 4471.7987690554, 4550.863474095782, 4553.726776393427, 4554.225781617133, 3879.903002424962, 3937.7637341759587, 4622.19111655459, 4622.497688251265, 4647.814087436464, 4700.365450664185, 5164.97848758473, 5506.174073888948, 5533.012173426385, 5542.224088627595, 6645.269020407752, 6732.394084532416, 6741.157355330583, 6756.391924726799, 6787.932120678829, 1535.0, 1547.8839087068516, 1549.093780138609, 1553.9145347005797, 1554.0209667909146, 983.6704703924122, 998.4608311511703, 998.9051040151174, 1029.5006921642996, 1046.8168070587617, 5366.570674346043, 6298.0, 6342.651154186564, 6359.473726305653, 6389.083275017476, 6813.897791533131, 6987.366569383892, 7020.613866237304, 7021.684024218923, 7023.595280943831, 5351.785928562814, 5781.4218578141845, 5848.824535263949, 6342.587731797418, 6355.396237357444, 3639.0, 3649.543807024122, 3685.539307586552, 3690.6309369063415, 3691.3171063353366, 5778.162166485836, 6035.909461358083, 6719.832004199934, 6930.757423490154, 7155.67799449026, 6986.126734158231, 7141.535800172972, 7159.89260161098, 7175.390091842148, 7184.748533801397, 6319.715612797435, 6580.407763301135, 6834.769741446587, 7101.325374089453, 7201.855962880713, 6965.860682786417, 6971.6862741175755, 6977.476689248429, 6998.2651821558, 7022.894656580258, 5644.576656750843, 6736.528443008942, 6795.572929684821, 6904.378605925491, 6935.751564718399, 5996.67018313997, 6713.160854893138, 6794.76218332356, 6965.199002114821, 7230.819229519304, 3842.69258459317, 3986.5016872890887, 4487.192305385062, 4496.190685676479, 4552.135094332067, 5936.228290322403, 6359.3640635936035, 6673.265940746611, 6976.372126508639, 7033.613151276729, 5620.297462817148, 6719.865602688016, 6758.290379510081, 6777.661116944035, 6810.965945170243, 6206.286277078194, 6521.739130434729, 6526.869462610626, 6679.766208182885, 6744.966275168593, 5472.699001554953, 5720.7974929651555, 6538.280789113099, 6632.701528431136, 6655.833604159935, 6245.96877015612, 6766.661666916733, 6788.1175447191545, 6792.83017924536, 6797.1843378794865, 5144.459831717765, 5459.235707001102, 5910.615809972338, 6337.415646088478, 6405.327440618668], "value": 4803.722502810463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.2368365848538, 733.9596322202278, 737.4395459450819, 740.7296336837054, 742.7029188324669, 15344.846551534481, 15562.221888905566, 15645.530634080982, 15674.843251567481, 16083.678326433464, 14893.851061489382, 15055.698886022274, 15062.6987460251, 15103.697926041472, 15144.167070811101, 903.905089965554, 928.9535523223846, 945.2060269373725, 977.6529332087114, 985.1035557642547, 982.3614650477211, 999.8750156230471, 1000.7898341348325, 1001.8697569315979, 1002.6791426743445, 1026.8151732688113, 1029.2486484866051, 1032.0298919016138, 1041.8593489878883, 1044.9425281609508, 1006.0, 1033.9844902326472, 1039.9480025998669, 1040.5109598488737, 1044.4725413666126, 753.9208383119803, 773.7949443397504, 776.6543887969799, 777.1567848883967, 777.5451360953849, 16195.595110122224, 16479.176041197894, 16523.421680241136, 16658.16709164537, 16860.578485537837, 14471.348789304506, 14523.491677791333, 14579.416823327054, 14600.415983360654, 14855.331510081964, 11674.883251167465, 11711.648650540412, 11855.184785086349, 11885.599238524264, 12148.635540933787, 3006.2183832203787, 3030.6211723534557, 3038.2860027893425, 3120.0483852425, 3136.341368312634, 107619.0, 109049.90950090477, 113211.0, 116221.41889290584, 116554.0, 8599.828003439896, 10368.118709909591, 10390.428526430967, 11244.943775281072, 11378.146639002109, 21419.250326238507, 24876.751232487444, 25045.87477062603, 25054.62418063694, 25105.874470627896, 7779.7666070017995, 7847.097583777939, 7878.606069696492, 7944.483608565425, 8050.919490805134, 4151.1075118848985, 4169.56219596944, 4170.436991006236, 4171.165766846643, 4180.811863466151, 3491.6682915123024, 4111.198316328288, 4132.028973191298, 4185.958140418617, 4209.7474151551005, 799.093029411622, 808.5633757770738, 826.98346033079, 841.6044459104211, 858.9785255368665, 529.3409704917402, 544.3331918400007, 568.9829305120853, 572.55305262741, 582.9387914269025, 8800.767892495056, 9999.551812916769, 10258.846117308247, 10433.158365255338, 10641.308314959502, 508.7100352798943, 532.6111938285073, 557.3033707865169, 579.2296245992903, 580.4369761331502, 4373.584509471595, 4749.976250118796, 4783.330333753277, 4785.612172470014, 4800.807967681323, 88483.0, 107532.0, 109663.45168274107, 110217.24456888642, 111554.44222778997, 74659.5068098635, 76512.61743691246, 77685.0, 80030.0, 82635.58682206551, 63870.0, 64516.0, 64899.0, 65778.0, 74259.62870185614, 10799.082078023455, 10834.02493775564, 10840.67477975662, 11046.33721976684, 11073.280236784583, 36678.8166059168, 36910.0, 37119.814400927826, 37127.6287237135, 37527.0, 48196.0, 49372.75313623409, 49542.0, 50299.49700503094, 50511.74744126256, 10302.885286435074, 11333.26333788301, 13160.736785264433, 13664.316784160554, 13817.170969741848, 11767.76464470723, 12150.939245303716, 13890.861091388957, 14134.78797818013, 14142.292885355897, 11244.606438774603, 11668.066554675435, 12585.748285034066, 13370.598882033555, 13564.321783910962, 13178.209307441584, 13449.596512104652, 13651.59045228605, 13660.385282662503, 13904.721905562035, 13000.739985200433, 13057.412416441093, 13236.404361803548, 13321.533746318832, 13701.0, 7385.446091543048, 9722.131971068693, 9783.8089004583, 10220.335678181193, 10533.210009249491, 7517.774466766005, 8763.298936085226, 9775.315727899264, 11145.164112691742, 11253.71865703364], "value": 7409.045713374467, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 171.0, 147.0, 117.0, 116.0, 118.0, 116.0, 131.0, 161.0, 155.0], "value": 136.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 114.0, 155.0, 112.0, 120.0, 158.0, 119.0, 139.0, 116.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 211.0, 216.0, 223.0, 208.0, 198.0, 203.0, 233.0, 250.0, 200.0], "value": 214.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 57.0, 89.0, 55.0, 68.0, 69.0, 85.0, 96.0, 57.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 73.0, 85.0, 64.0, 104.0, 72.0, 122.0, 89.0, 69.0, 82.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 107.0, 88.0, 89.0, 131.0, 137.0, 136.0, 88.0, 89.0, 89.0], "value": 104.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 97.0, 95.0, 96.0, 99.0, 97.0, 105.0, 119.0, 98.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 90.0, 90.0, 97.0, 92.0, 92.0, 96.0, 93.0, 130.0, 147.0], "value": 103.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 65.0, 66.0, 87.0, 102.0, 101.0, 92.0, 84.0, 67.0], "value": 80.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 62.0, 67.0, 64.0, 64.0, 60.0, 59.0, 59.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 73.0, 85.0, 109.0, 84.0, 84.0, 84.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 150.0, 133.0, 146.0, 156.0, 154.0, 155.0, 273.0, 157.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 243.0, 243.0, 243.0, 233.0, 190.0, 185.0, 186.0, 192.0, 170.0], "value": 207.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 68.0, 70.0, 67.0, 70.0, 68.0, 67.0, 68.0], "value": 68.7, "unit": "score"}]}]} 20:11:04 INFO - Return code: 0 20:11:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:11:04 ERROR - # TBPL SUCCESS # 20:11:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:11:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:11:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:11:04 INFO - 2017-03-25 20:11:04.648 screenresolution[1661:11908] starting screenresolution argv=screenresolution get 20:11:04 INFO - 2017-03-25 20:11:04.651 screenresolution[1661:11908] Display 0: 1600x1200x32@60 20:11:04 INFO - 2017-03-25 20:11:04.657 screenresolution[1662:11911] starting screenresolution argv=screenresolution list 20:11:04 INFO - Available Modes on Display 0 20:11:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:11:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:11:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:11:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:11:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:11:04 INFO - Intel Iris: 20:11:04 INFO - Chipset Model: Intel Iris 20:11:04 INFO - Type: GPU 20:11:04 INFO - Bus: Built-In 20:11:04 INFO - VRAM (Dynamic, Max): 1536 MB 20:11:04 INFO - Vendor: Intel (0x8086) 20:11:04 INFO - Device ID: 0x0a2e 20:11:04 INFO - Revision ID: 0x0009 20:11:04 INFO - Displays: 20:11:04 INFO - Display: 20:11:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:11:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:11:04 INFO - Display Serial Number: 1600x1200 60 20:11:04 INFO - Main Display: Yes 20:11:04 INFO - Mirror: Off 20:11:04 INFO - Online: Yes 20:11:04 INFO - Rotation: Supported 20:11:04 INFO - Return code: 0 20:11:04 INFO - Running post-action listener: _resource_record_post_action 20:11:04 INFO - [mozharness: 2017-03-26 03:11:04.897622Z] Finished run-tests step (success) 20:11:04 INFO - Running post-run listener: _resource_record_post_run 20:11:04 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 44983808; Write bytes: 531864576; Read time: 345; Write time: 1739 20:11:04 INFO - TinderboxPrint: CPU usage
54.3% 20:11:04 INFO - TinderboxPrint: I/O read bytes / time
44,983,808 / 345 20:11:04 INFO - TinderboxPrint: I/O write bytes / time
531,864,576 / 1,739 20:11:04 INFO - TinderboxPrint: CPU idle
2,194.2 (45.7%) 20:11:04 INFO - TinderboxPrint: CPU system
968.6 (20.2%) 20:11:04 INFO - TinderboxPrint: CPU user
1,638.9 (34.1%) 20:11:04 INFO - TinderboxPrint: Swap in / out
246,419,456 / 0 20:11:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207028736; Write bytes: 202485760; Read time: 15595; Write time: 423 20:11:04 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 42944000; Write bytes: 318417920; Read time: 325; Write time: 1279 20:11:05 INFO - Running post-run listener: _upload_blobber_files 20:11:05 INFO - Blob upload gear active. 20:11:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:11:05 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 20:11:05 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:11:05 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:11:05 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:11:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:06 INFO - (blobuploader) - INFO - Done attempting. 20:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:07 INFO - (blobuploader) - INFO - Done attempting. 20:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:09 INFO - (blobuploader) - INFO - Done attempting. 20:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:11 INFO - (blobuploader) - INFO - Done attempting. 20:11:11 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:11 INFO - Return code: 0 20:11:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:11:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6269d47b79ed3aac366be06e448ff4651f49f515678ee54ba135279f48cbffd205c6678fc82e6eb8218d691b5a6f7ee13a626009a48c32d5bd5675de5bea6105", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c446ab2a4ddb5ea17dbd9983d133c74d44a6db5d5d927a2b10307fb73e5015f88afe10b6723d0da6ce9c20e0c92bf066fa4a724dd4f42df83f354bb3747bdb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c390cc91e9c847d38286e8a0cb8745a630d3ad362ad6c023bbc26b902a501661c166af71ceca76e18cc276e39d3c46f05345a51fd1bed07295ef8095f7b19f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3923a468f59708b4bdfe958c88028839a7397de24ed2ed36972b98d04bf3709f175ec24dd6742e9d9f7064eca11853e80d5388ea8aeb1ed2c85d72aa0fc616be"} 20:11:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:11:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:11:11 INFO - Contents: 20:11:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6269d47b79ed3aac366be06e448ff4651f49f515678ee54ba135279f48cbffd205c6678fc82e6eb8218d691b5a6f7ee13a626009a48c32d5bd5675de5bea6105", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c446ab2a4ddb5ea17dbd9983d133c74d44a6db5d5d927a2b10307fb73e5015f88afe10b6723d0da6ce9c20e0c92bf066fa4a724dd4f42df83f354bb3747bdb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c390cc91e9c847d38286e8a0cb8745a630d3ad362ad6c023bbc26b902a501661c166af71ceca76e18cc276e39d3c46f05345a51fd1bed07295ef8095f7b19f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3923a468f59708b4bdfe958c88028839a7397de24ed2ed36972b98d04bf3709f175ec24dd6742e9d9f7064eca11853e80d5388ea8aeb1ed2c85d72aa0fc616be"} 20:11:11 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:11 INFO - Copying logs to upload dir... 20:11:11 INFO - mkdir: /builds/slave/test/build/upload/logs 20:11:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.137293 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-25 20:11:11.401533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:11.405420) ========= 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.0GluL0u1GE/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.40snXZyXTi/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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/Firefox/sha512/6269d47b79ed3aac366be06e448ff4651f49f515678ee54ba135279f48cbffd205c6678fc82e6eb8218d691b5a6f7ee13a626009a48c32d5bd5675de5bea6105", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c446ab2a4ddb5ea17dbd9983d133c74d44a6db5d5d927a2b10307fb73e5015f88afe10b6723d0da6ce9c20e0c92bf066fa4a724dd4f42df83f354bb3747bdb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c390cc91e9c847d38286e8a0cb8745a630d3ad362ad6c023bbc26b902a501661c166af71ceca76e18cc276e39d3c46f05345a51fd1bed07295ef8095f7b19f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3923a468f59708b4bdfe958c88028839a7397de24ed2ed36972b98d04bf3709f175ec24dd6742e9d9f7064eca11853e80d5388ea8aeb1ed2c85d72aa0fc616be"} build_url:https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6269d47b79ed3aac366be06e448ff4651f49f515678ee54ba135279f48cbffd205c6678fc82e6eb8218d691b5a6f7ee13a626009a48c32d5bd5675de5bea6105", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c446ab2a4ddb5ea17dbd9983d133c74d44a6db5d5d927a2b10307fb73e5015f88afe10b6723d0da6ce9c20e0c92bf066fa4a724dd4f42df83f354bb3747bdb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c390cc91e9c847d38286e8a0cb8745a630d3ad362ad6c023bbc26b902a501661c166af71ceca76e18cc276e39d3c46f05345a51fd1bed07295ef8095f7b19f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3923a468f59708b4bdfe958c88028839a7397de24ed2ed36972b98d04bf3709f175ec24dd6742e9d9f7064eca11853e80d5388ea8aeb1ed2c85d72aa0fc616be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:11.439856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:11.440209) ========= 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.0GluL0u1GE/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.40snXZyXTi/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.005122 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:11.488829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 20:11:11.489152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 20:11:11.489516) ========= ========= Total master_lag: 0.18 =========