builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0282 starttime: 1491600805.32 results: success (0) buildid: 20170407131422 builduid: 822f04c07d5a4e7585f7c3b897f48835 revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.318162) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.318588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.318885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.344411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.344808) ========= 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.03RaeYJpTW/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.hq01Qx8StG/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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-04-07 14:33:25-- 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% 20.1M=0.001s 2017-04-07 14:33:25 (20.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.475927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.476241) ========= 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.03RaeYJpTW/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.hq01Qx8StG/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.022981 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:25.524658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 14:33:25.525019) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35c7be9c2db288d1d449e3cc586c4164d642c5fd --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 35c7be9c2db288d1d449e3cc586c4164d642c5fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.03RaeYJpTW/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.hq01Qx8StG/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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-04-07 14:33:25,619 truncating revision to first 12 chars 2017-04-07 14:33:25,619 Setting DEBUG logging. 2017-04-07 14:33:25,619 attempt 1/10 2017-04-07 14:33:25,619 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35c7be9c2db2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 14:33:27,676 unpacking tar archive at: mozilla-central-35c7be9c2db2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.314201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 14:33:27.863372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:27.863774) ========= script_repo_revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:27.864168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:27.864446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 14:33:27.885259) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-07 14:33:27.885704) ========= /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.03RaeYJpTW/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.hq01Qx8StG/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:33:28 INFO - MultiFileLogger online at 20170407 14:33:28 in /builds/slave/test 14:33:28 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 14:33:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:33:28 INFO - {'append_to_log': False, 14:33:28 INFO - 'base_work_dir': '/builds/slave/test', 14:33:28 INFO - 'blob_upload_branch': 'Firefox', 14:33:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:33:28 INFO - 'branch': 'Firefox', 14:33:28 INFO - 'buildbot_json_path': 'buildprops.json', 14:33:28 INFO - 'config_files': ('talos/mac_config.py',), 14:33:28 INFO - 'default_actions': ('clobber', 14:33:28 INFO - 'read-buildbot-config', 14:33:28 INFO - 'download-and-extract', 14:33:28 INFO - 'populate-webroot', 14:33:28 INFO - 'create-virtualenv', 14:33:28 INFO - 'install', 14:33:28 INFO - 'run-tests'), 14:33:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:33:28 INFO - 'download_minidump_stackwalk': True, 14:33:28 INFO - 'download_symbols': 'ondemand', 14:33:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:33:28 INFO - 'tooltool.py': '/tools/tooltool.py', 14:33:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:33:28 INFO - '/tools/misc-python/virtualenv.py')}, 14:33:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:33:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:33:28 INFO - 'gecko_profile': False, 14:33:28 INFO - 'gecko_profile_interval': 0, 14:33:28 INFO - 'installer_path': 'installer.exe', 14:33:28 INFO - 'log_level': 'info', 14:33:28 INFO - 'log_name': 'talos', 14:33:28 INFO - 'log_to_console': True, 14:33:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:33:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:33:28 INFO - 'opt_config_files': (), 14:33:28 INFO - 'pip_index': False, 14:33:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:33:28 INFO - 'cmd': ('bash', 14:33:28 INFO - '-c', 14:33:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:33:28 INFO - 'enabled': True, 14:33:28 INFO - 'halt_on_failure': False, 14:33:28 INFO - 'name': 'check_screen_resolution'},), 14:33:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:33:28 INFO - 'cmd': ('bash', 14:33:28 INFO - '-c', 14:33:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:33:28 INFO - 'enabled': True, 14:33:28 INFO - 'halt_on_failure': False, 14:33:28 INFO - 'name': 'check_screen_resolution'},), 14:33:28 INFO - 'run_cmd_checks_enabled': True, 14:33:28 INFO - 'suite': 'dromaeojs-e10s', 14:33:28 INFO - 'system_bits': '32', 14:33:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:33:28 INFO - 'title': 't-yosemite-r7-0282', 14:33:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:33:28 INFO - 'use_talos_json': True, 14:33:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:33:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:33:28 INFO - 'work_dir': 'build'} 14:33:28 INFO - [mozharness: 2017-04-07 21:33:28.104691Z] Running clobber step. 14:33:28 INFO - Running pre-action listener: _resource_record_pre_action 14:33:28 INFO - Running main action method: clobber 14:33:28 INFO - rmtree: /builds/slave/test/build 14:33:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:33:29 INFO - Running post-action listener: _resource_record_post_action 14:33:29 INFO - [mozharness: 2017-04-07 21:33:29.939517Z] Finished clobber step (success) 14:33:29 INFO - [mozharness: 2017-04-07 21:33:29.939716Z] Running read-buildbot-config step. 14:33:29 INFO - Running pre-action listener: _resource_record_pre_action 14:33:29 INFO - Running main action method: read_buildbot_config 14:33:29 INFO - Using buildbot properties: 14:33:29 INFO - { 14:33:29 INFO - "project": "", 14:33:29 INFO - "product": "firefox", 14:33:29 INFO - "script_repo_revision": "production", 14:33:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:33:29 INFO - "repository": "", 14:33:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:33:29 INFO - "buildid": "20170407131422", 14:33:29 INFO - "pgo_build": "False", 14:33:29 INFO - "basedir": "/builds/slave/test", 14:33:29 INFO - "buildnumber": 39, 14:33:29 INFO - "slavename": "t-yosemite-r7-0282", 14:33:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:33:29 INFO - "platform": "yosemite_r7", 14:33:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:33:29 INFO - "branch": "mozilla-central", 14:33:29 INFO - "repo_path": "mozilla-central", 14:33:29 INFO - "revision": "35c7be9c2db288d1d449e3cc586c4164d642c5fd", 14:33:29 INFO - "stage_platform": "macosx64", 14:33:29 INFO - "builduid": "822f04c07d5a4e7585f7c3b897f48835", 14:33:29 INFO - "slavebuilddir": "test" 14:33:29 INFO - } 14:33:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:33:29 INFO - Running post-action listener: _resource_record_post_action 14:33:29 INFO - [mozharness: 2017-04-07 21:33:29.943002Z] Finished read-buildbot-config step (success) 14:33:29 INFO - [mozharness: 2017-04-07 21:33:29.943145Z] Running download-and-extract step. 14:33:29 INFO - Running pre-action listener: _resource_record_pre_action 14:33:29 INFO - Running main action method: download_and_extract 14:33:29 INFO - mkdir: /builds/slave/test/build/tests 14:33:29 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')]} 14:33:29 INFO - trying https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:29 INFO - Downloading https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/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 14:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/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 14:33:30 INFO - Downloaded 1325 bytes. 14:33:30 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:30 INFO - Using the following test package requirements: 14:33:30 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:33:30 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:33:30 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:33:30 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:33:30 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'jsshell-mac.zip'], 14:33:30 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:33:30 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:33:30 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:33:30 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:33:30 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:33:30 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:30 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:33:30 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:33:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:33:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:33:30 INFO - Fetch https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:33:32 INFO - Expected file size: 52521953 14:33:32 INFO - Obtained file size: 52521953 14:33:48 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 14:33:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:33:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:33:48 INFO - Fetch https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:33:50 INFO - Expected file size: 52521953 14:33:50 INFO - Obtained file size: 52521953 14:34:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:34:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:34:06 INFO - Fetch https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:34:07 INFO - Expected file size: 14404138 14:34:07 INFO - Obtained file size: 14404138 14:34:07 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')]} 14:34:07 INFO - trying https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:07 INFO - Downloading https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:34:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/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 14:34:09 INFO - Downloaded 70935825 bytes. 14:34:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:09 INFO - mkdir: /builds/slave/test/properties 14:34:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:34:09 INFO - Writing to file /builds/slave/test/properties/build_url 14:34:09 INFO - Contents: 14:34:09 INFO - build_url:https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:10 INFO - Running post-action listener: _resource_record_post_action 14:34:10 INFO - Running post-action listener: set_extra_try_arguments 14:34:10 INFO - [mozharness: 2017-04-07 21:34:10.604371Z] Finished download-and-extract step (success) 14:34:10 INFO - [mozharness: 2017-04-07 21:34:10.604528Z] Running populate-webroot step. 14:34:10 INFO - Running pre-action listener: _resource_record_pre_action 14:34:10 INFO - Running main action method: populate_webroot 14:34:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:10 INFO - '--tppagecycles', 14:34:10 INFO - '7'], 14:34:10 INFO - 'tests': ['tsvgm']}}, 14:34:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:34:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:34:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:34:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['damp', 'tps']}, 14:34:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:34:10 INFO - 'tests': ['damp', 'tps']}, 14:34:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['dromaeo_dom']}, 14:34:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['basic_compositor_video']}, 14:34:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:34:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other-e10s': {'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tsvgx', 14:34:10 INFO - 'tsvgr_opacity', 14:34:10 INFO - 'tart', 14:34:10 INFO - 'tscrollx', 14:34:10 INFO - 'cart', 14:34:10 INFO - 'tsvg_static']}, 14:34:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:34:10 INFO - 'tsvgr_opacity', 14:34:10 INFO - 'tart', 14:34:10 INFO - 'tscrollx', 14:34:10 INFO - 'cart', 14:34:10 INFO - 'tsvg_static']}, 14:34:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tp5o']}, 14:34:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:34:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s', 14:34:10 INFO - '--xperf_path', 14:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:10 INFO - 'tests': ['tp5n']}, 14:34:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:34:10 INFO - 'talos_options': ['--xperf_path', 14:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:10 INFO - 'tests': ['tp5n']}}, 14:34:10 INFO - 'talos.zip': {'path': '', 14:34:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:10 INFO - Running post-action listener: _resource_record_post_action 14:34:10 INFO - [mozharness: 2017-04-07 21:34:10.622909Z] Finished populate-webroot step (success) 14:34:10 INFO - [mozharness: 2017-04-07 21:34:10.623035Z] Running create-virtualenv step. 14:34:10 INFO - Running pre-action listener: _resource_record_pre_action 14:34:10 INFO - Running main action method: create_virtualenv 14:34:10 INFO - Creating virtualenv /builds/slave/test/build/venv 14:34:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:34:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:34:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:10 INFO - Using real prefix '/tools/python27' 14:34:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:34:11 INFO - Installing distribute.............................................................................................................................................................................................done. 14:34:14 INFO - Installing pip.................done. 14:34:14 INFO - Return code: 0 14:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:34:14 INFO - Reading from file tmpfile_stdout 14:34:14 INFO - Output received: 14:34:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:34:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:14 INFO - 'HOME': '/Users/cltbld', 14:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:14 INFO - 'LOGNAME': 'cltbld', 14:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:14 INFO - 'MOZ_NO_REMOTE': '1', 14:34:14 INFO - 'NO_EM_RESTART': '1', 14:34:14 INFO - 'PAGER': '/bin/cat', 14:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:14 INFO - 'PWD': '/builds/slave/test', 14:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:14 INFO - 'SHELL': '/bin/bash', 14:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:14 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:14 INFO - 'USER': 'cltbld', 14:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:14 INFO - 'XPC_FLAGS': '0x0', 14:34:14 INFO - 'XPC_SERVICE_NAME': '0', 14:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:34:15 INFO - Cleaning up... 14:34:15 INFO - Return code: 0 14:34:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:15 INFO - 'HOME': '/Users/cltbld', 14:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:15 INFO - 'LOGNAME': 'cltbld', 14:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:15 INFO - 'MOZ_NO_REMOTE': '1', 14:34:15 INFO - 'NO_EM_RESTART': '1', 14:34:15 INFO - 'PAGER': '/bin/cat', 14:34:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:15 INFO - 'PWD': '/builds/slave/test', 14:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:15 INFO - 'SHELL': '/bin/bash', 14:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:15 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:15 INFO - 'USER': 'cltbld', 14:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:15 INFO - 'XPC_FLAGS': '0x0', 14:34:15 INFO - 'XPC_SERVICE_NAME': '0', 14:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:15 INFO - Downloading/unpacking psutil>=3.1.1 14:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:34:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:19 INFO - Installing collected packages: psutil 14:34:19 INFO - Running setup.py install for psutil 14:34:19 INFO - building 'psutil._psutil_osx' extension 14:34:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:34:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:34:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:34:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:34:19 INFO - building 'psutil._psutil_posix' extension 14:34:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:34:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:34:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:34:19 INFO - ^ 14:34:19 INFO - 1 warning generated. 14:34:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:34:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:19 INFO - Successfully installed psutil 14:34:19 INFO - Cleaning up... 14:34:20 INFO - Return code: 0 14:34:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:34:20 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')]} 14:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:20 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')]} 14:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:20 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 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:20 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 14:34:20 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 14:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:20 INFO - 'HOME': '/Users/cltbld', 14:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:20 INFO - 'LOGNAME': 'cltbld', 14:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:20 INFO - 'MOZ_NO_REMOTE': '1', 14:34:20 INFO - 'NO_EM_RESTART': '1', 14:34:20 INFO - 'PAGER': '/bin/cat', 14:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:20 INFO - 'PWD': '/builds/slave/test', 14:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:20 INFO - 'SHELL': '/bin/bash', 14:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:20 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:20 INFO - 'USER': 'cltbld', 14:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:20 INFO - 'XPC_FLAGS': '0x0', 14:34:20 INFO - 'XPC_SERVICE_NAME': '0', 14:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:34:23 INFO - Installing collected packages: mozsystemmonitor 14:34:23 INFO - Running setup.py install for mozsystemmonitor 14:34:23 INFO - Successfully installed mozsystemmonitor 14:34:23 INFO - Cleaning up... 14:34:23 INFO - Return code: 0 14:34:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:24 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 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:24 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 14:34:24 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 14:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:24 INFO - 'HOME': '/Users/cltbld', 14:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:24 INFO - 'LOGNAME': 'cltbld', 14:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:24 INFO - 'MOZ_NO_REMOTE': '1', 14:34:24 INFO - 'NO_EM_RESTART': '1', 14:34:24 INFO - 'PAGER': '/bin/cat', 14:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:24 INFO - 'PWD': '/builds/slave/test', 14:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:24 INFO - 'SHELL': '/bin/bash', 14:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:24 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:24 INFO - 'USER': 'cltbld', 14:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:24 INFO - 'XPC_FLAGS': '0x0', 14:34:24 INFO - 'XPC_SERVICE_NAME': '0', 14:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:24 INFO - Downloading/unpacking jsonschema==2.5.1 14:34:24 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 14:34:24 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 14:34:24 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 14:34:24 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 14:34:24 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 14:34:24 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 14:34:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:34:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:34:27 INFO - warning: no files found matching '*.txt' 14:34:27 INFO - no previously-included directories found matching 'build' 14:34:27 INFO - no previously-included directories found matching 'dist' 14:34:27 INFO - no previously-included directories found matching '.git*' 14:34:27 INFO - Installing collected packages: jsonschema, functools32 14:34:27 INFO - Running setup.py install for functools32 14:34:27 INFO - warning: no files found matching '*.txt' 14:34:27 INFO - no previously-included directories found matching 'build' 14:34:27 INFO - no previously-included directories found matching 'dist' 14:34:27 INFO - no previously-included directories found matching '.git*' 14:34:27 INFO - Successfully installed jsonschema functools32 14:34:27 INFO - Cleaning up... 14:34:27 INFO - Return code: 0 14:34:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:27 INFO - 'HOME': '/Users/cltbld', 14:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:27 INFO - 'LOGNAME': 'cltbld', 14:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:27 INFO - 'MOZ_NO_REMOTE': '1', 14:34:27 INFO - 'NO_EM_RESTART': '1', 14:34:27 INFO - 'PAGER': '/bin/cat', 14:34:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:27 INFO - 'PWD': '/builds/slave/test', 14:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:27 INFO - 'SHELL': '/bin/bash', 14:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:27 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:27 INFO - 'USER': 'cltbld', 14:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:27 INFO - 'XPC_FLAGS': '0x0', 14:34:27 INFO - 'XPC_SERVICE_NAME': '0', 14:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:34:28 INFO - Cleaning up... 14:34:28 INFO - Return code: 0 14:34:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:28 INFO - 'HOME': '/Users/cltbld', 14:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:28 INFO - 'LOGNAME': 'cltbld', 14:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:28 INFO - 'MOZ_NO_REMOTE': '1', 14:34:28 INFO - 'NO_EM_RESTART': '1', 14:34:28 INFO - 'PAGER': '/bin/cat', 14:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:28 INFO - 'PWD': '/builds/slave/test', 14:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:28 INFO - 'SHELL': '/bin/bash', 14:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:28 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:28 INFO - 'USER': 'cltbld', 14:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:28 INFO - 'XPC_FLAGS': '0x0', 14:34:28 INFO - 'XPC_SERVICE_NAME': '0', 14:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:34:28 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 14:34:28 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 14:34:28 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 14:34:28 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 14:34:28 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 14:34:28 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 14:34:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:34:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:34:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:32 INFO - Downloading docopt-0.6.1.tar.gz 14:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:34:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:34:32 INFO - Running setup.py install for blobuploader 14:34:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:34:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:34:32 INFO - Running setup.py install for requests 14:34:33 INFO - Running setup.py install for docopt 14:34:33 INFO - Successfully installed blobuploader requests docopt 14:34:33 INFO - Cleaning up... 14:34:33 INFO - Return code: 0 14:34:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:33 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')]} 14:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:33 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')]} 14:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:33 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 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:33 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 14:34:33 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 14:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:33 INFO - 'HOME': '/Users/cltbld', 14:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:33 INFO - 'LOGNAME': 'cltbld', 14:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:33 INFO - 'MOZ_NO_REMOTE': '1', 14:34:33 INFO - 'NO_EM_RESTART': '1', 14:34:33 INFO - 'PAGER': '/bin/cat', 14:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:33 INFO - 'PWD': '/builds/slave/test', 14:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:33 INFO - 'SHELL': '/bin/bash', 14:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:33 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:33 INFO - 'USER': 'cltbld', 14:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:33 INFO - 'XPC_FLAGS': '0x0', 14:34:33 INFO - 'XPC_SERVICE_NAME': '0', 14:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:33 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-MuzZ3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:33 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-5dLj0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:33 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-T33vw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:33 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-fjywsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:33 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-_Q_FWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-hNGoEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-sHBMuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-2_sRhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-FU8wrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-wrQHWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-dIcrit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-nVH3WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-_1bM1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-8PXz8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:34 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-BjkWAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:35 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-ULA7a0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:35 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-M94Fo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:34:35 INFO - Running setup.py install for manifestparser 14:34:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:34:35 INFO - Running setup.py install for mozcrash 14:34:35 INFO - Running setup.py install for mozdebug 14:34:35 INFO - Running setup.py install for mozdevice 14:34:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:34:35 INFO - Running setup.py install for mozfile 14:34:36 INFO - Running setup.py install for mozhttpd 14:34:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Running setup.py install for mozinfo 14:34:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Running setup.py install for mozInstall 14:34:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Running setup.py install for mozleak 14:34:36 INFO - Running setup.py install for mozlog 14:34:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Running setup.py install for moznetwork 14:34:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:34:36 INFO - Running setup.py install for mozprocess 14:34:37 INFO - Running setup.py install for mozprofile 14:34:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:34:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:34:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:34:37 INFO - Running setup.py install for mozrunner 14:34:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:34:37 INFO - Running setup.py install for mozscreenshot 14:34:37 INFO - Running setup.py install for moztest 14:34:37 INFO - Running setup.py install for mozversion 14:34:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:34:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:34:37 INFO - Cleaning up... 14:34:37 INFO - Return code: 0 14:34:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:37 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')]} 14:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:37 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')]} 14:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:37 INFO - 'HOME': '/Users/cltbld', 14:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:37 INFO - 'LOGNAME': 'cltbld', 14:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:37 INFO - 'MOZ_NO_REMOTE': '1', 14:34:37 INFO - 'NO_EM_RESTART': '1', 14:34:37 INFO - 'PAGER': '/bin/cat', 14:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:37 INFO - 'PWD': '/builds/slave/test', 14:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:37 INFO - 'SHELL': '/bin/bash', 14:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:37 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:37 INFO - 'USER': 'cltbld', 14:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:37 INFO - 'XPC_FLAGS': '0x0', 14:34:37 INFO - 'XPC_SERVICE_NAME': '0', 14:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-9JzWeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:38 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)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-8_jwmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:38 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)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-dUL3v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:38 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)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-SzMXHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-XCDj37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-LQ6w29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-WwDx5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-WUra1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:38 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-_mHGN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-hU8yiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:39 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)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-gw3Kch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:39 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)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-0LTeTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:39 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)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-qXyAGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-MTFxsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-V0b71X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-IOh6Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:39 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-5_KNbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:34:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:42 INFO - Downloading blessings-1.6.tar.gz 14:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:34:42 INFO - Installing collected packages: blessings 14:34:42 INFO - Running setup.py install for blessings 14:34:42 INFO - Successfully installed blessings 14:34:42 INFO - Cleaning up... 14:34:42 INFO - Return code: 0 14:34:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:43 INFO - Reading from file tmpfile_stdout 14:34:43 INFO - Current package versions: 14:34:43 INFO - blessings == 1.6 14:34:43 INFO - blobuploader == 1.2.4 14:34:43 INFO - docopt == 0.6.1 14:34:43 INFO - functools32 == 3.2.3-2 14:34:43 INFO - jsonschema == 2.5.1 14:34:43 INFO - manifestparser == 1.1 14:34:43 INFO - mozInstall == 1.12 14:34:43 INFO - mozcrash == 1.0 14:34:43 INFO - mozdebug == 0.1 14:34:43 INFO - mozdevice == 0.50 14:34:43 INFO - mozfile == 1.2 14:34:43 INFO - mozhttpd == 0.7 14:34:43 INFO - mozinfo == 0.9 14:34:43 INFO - mozleak == 0.1 14:34:43 INFO - mozlog == 3.4 14:34:43 INFO - moznetwork == 0.27 14:34:43 INFO - mozprocess == 0.25 14:34:43 INFO - mozprofile == 0.28 14:34:43 INFO - mozrunner == 6.13 14:34:43 INFO - mozscreenshot == 0.1 14:34:43 INFO - mozsystemmonitor == 0.3 14:34:43 INFO - moztest == 0.8 14:34:43 INFO - mozversion == 1.4 14:34:43 INFO - psutil == 3.1.1 14:34:43 INFO - requests == 1.2.3 14:34:43 INFO - wsgiref == 0.1.2 14:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:43 INFO - 'HOME': '/Users/cltbld', 14:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:43 INFO - 'LOGNAME': 'cltbld', 14:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:43 INFO - 'MOZ_NO_REMOTE': '1', 14:34:43 INFO - 'NO_EM_RESTART': '1', 14:34:43 INFO - 'PAGER': '/bin/cat', 14:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:43 INFO - 'PWD': '/builds/slave/test', 14:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:43 INFO - 'SHELL': '/bin/bash', 14:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:43 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:43 INFO - 'USER': 'cltbld', 14:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:43 INFO - 'XPC_FLAGS': '0x0', 14:34:43 INFO - 'XPC_SERVICE_NAME': '0', 14:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:34:43 INFO - Cleaning up... 14:34:43 INFO - Return code: 0 14:34:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdacd3bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, '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.03RaeYJpTW/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.hq01Qx8StG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 14:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:34: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 14:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:43 INFO - 'HOME': '/Users/cltbld', 14:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:43 INFO - 'LOGNAME': 'cltbld', 14:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:43 INFO - 'MOZ_NO_REMOTE': '1', 14:34:43 INFO - 'NO_EM_RESTART': '1', 14:34:43 INFO - 'PAGER': '/bin/cat', 14:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:43 INFO - 'PWD': '/builds/slave/test', 14:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:43 INFO - 'SHELL': '/bin/bash', 14:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:34:43 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:43 INFO - 'USER': 'cltbld', 14:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:43 INFO - 'XPC_FLAGS': '0x0', 14:34:43 INFO - 'XPC_SERVICE_NAME': '0', 14:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:34:43 INFO - Cleaning up... 14:34:43 INFO - Return code: 0 14:34:43 INFO - Running post-action listener: _resource_record_post_action 14:34:43 INFO - Running post-action listener: _start_resource_monitoring 14:34:43 INFO - Starting resource monitoring. 14:34:43 INFO - [mozharness: 2017-04-07 21:34:43.783978Z] Finished create-virtualenv step (success) 14:34:43 INFO - [mozharness: 2017-04-07 21:34:43.784973Z] Running install step. 14:34:43 INFO - Running pre-action listener: _resource_record_pre_action 14:34:43 INFO - Running main action method: install 14:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:44 INFO - Reading from file tmpfile_stdout 14:34:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:34:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:34:44 INFO - Reading from file tmpfile_stdout 14:34:44 INFO - Output received: 14:34:44 INFO - Usage: mozinstall [options] installer 14:34:44 INFO - Options: 14:34:44 INFO - -h, --help show this help message and exit 14:34:44 INFO - -d DEST, --destination=DEST 14:34:44 INFO - Directory to install application into. [default: 14:34:44 INFO - "/builds/slave/test"] 14:34:44 INFO - --app=APP Application being installed. [default: firefox] 14:34:44 INFO - mkdir: /builds/slave/test/build/application 14:34:44 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'] 14:34:44 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 14:35:04 INFO - Reading from file tmpfile_stdout 14:35:04 INFO - Output received: 14:35:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:35:04 INFO - Running post-action listener: _resource_record_post_action 14:35:04 INFO - [mozharness: 2017-04-07 21:35:04.481683Z] Finished install step (success) 14:35:04 INFO - [mozharness: 2017-04-07 21:35:04.481816Z] Running run-tests step. 14:35:04 INFO - Running pre-action listener: _resource_record_pre_action 14:35:04 INFO - Running main action method: run_tests 14:35:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:35:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:35:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:35:04 INFO - 2017-04-07 14:35:04.496 screenresolution[1896:17958] starting screenresolution argv=screenresolution get 14:35:04 INFO - 2017-04-07 14:35:04.499 screenresolution[1896:17958] Display 0: 1600x1200x32@60 14:35:04 INFO - 2017-04-07 14:35:04.504 screenresolution[1897:17961] starting screenresolution argv=screenresolution list 14:35:04 INFO - Available Modes on Display 0 14:35:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:35:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:35:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:35:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:35:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:35:04 INFO - Intel Iris: 14:35:04 INFO - Chipset Model: Intel Iris 14:35:04 INFO - Type: GPU 14:35:04 INFO - Bus: Built-In 14:35:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:35:04 INFO - Vendor: Intel (0x8086) 14:35:04 INFO - Device ID: 0x0a2e 14:35:04 INFO - Revision ID: 0x0009 14:35:04 INFO - Displays: 14:35:04 INFO - Display: 14:35:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:35:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:35:04 INFO - Display Serial Number: 1600x1200 60 14:35:04 INFO - Main Display: Yes 14:35:04 INFO - Mirror: Off 14:35:04 INFO - Online: Yes 14:35:04 INFO - Rotation: Supported 14:35:04 INFO - Return code: 0 14:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:35:04 INFO - Python 2.7.3 14:35:04 INFO - Return code: 0 14:35:04 INFO - grabbing minidump binary from tooltool 14:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b1d30>, '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 0x10c1d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:35:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:35:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:35:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:35:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:04 INFO - Return code: 0 14:35:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:35:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:35:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:35:04 INFO - ENV: RUST_BACKTRACE is now 1 14:35:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:35:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:35:04 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/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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 14:35:04 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/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0282 --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 14:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03RaeYJpTW/Render', 14:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:04 INFO - 'HOME': '/Users/cltbld', 14:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:04 INFO - 'LOGNAME': 'cltbld', 14:35:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:35:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:04 INFO - 'MOZ_NO_REMOTE': '1', 14:35:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:35:04 INFO - 'NO_EM_RESTART': '1', 14:35:04 INFO - 'PAGER': '/bin/cat', 14:35:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:04 INFO - 'PWD': '/builds/slave/test', 14:35:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:04 INFO - 'RUST_BACKTRACE': '1', 14:35:04 INFO - 'SHELL': '/bin/bash', 14:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hq01Qx8StG/Listeners', 14:35:04 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 14:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:04 INFO - 'USER': 'cltbld', 14:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:04 INFO - 'XPC_FLAGS': '0x0', 14:35:04 INFO - 'XPC_SERVICE_NAME': '0', 14:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:04 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/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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 14:35:05 INFO - mozversion application_buildid: 20170407131422 14:35:05 INFO - mozversion application_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 14:35:05 INFO - mozversion application_display_name: Nightly 14:35:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:05 INFO - mozversion application_name: Firefox 14:35:05 INFO - mozversion application_remotingname: firefox 14:35:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:35:05 INFO - mozversion application_vendor: Mozilla 14:35:05 INFO - mozversion application_version: 55.0a1 14:35:05 INFO - mozversion platform_buildid: 20170407131422 14:35:05 INFO - mozversion platform_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 14:35:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:35:05 INFO - mozversion platform_version: 55.0a1 14:35:05 INFO - using testdate: 1491600905 14:35:05 INFO - actual date: 1491600905 14:35:05 INFO - starting webserver on 'localhost:54242' 14:35:05 INFO - SUITE-START | Running 2 tests 14:35:05 INFO - TEST-START | dromaeo_css 14:35:05 INFO - operating with platform_type : mac_ 14:35:05 INFO - Initialising browser for dromaeo_css test... 14:35:05 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmp3kMHKQ/profile http://localhost:54242/getInfo.html) 14:35:05 INFO - PID 1907 | 1491600905718 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:35:05 INFO - PID 1907 | 1491600905719 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method install 14:35:05 INFO - PID 1907 | 1491600905770 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:35:08 INFO - PID 1907 | 2017-04-07 14:35:08.099 plugin-container[1909:18130] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 14:35:08 INFO - PID 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:08 INFO - PID 1907 | 2017-04-07 14:35:08.102 plugin-container[1909:18130] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 14:35:08 INFO - PID 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:08 INFO - PID 1907 | 2017-04-07 14:35:08.102 plugin-container[1909:18130] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:35:08 INFO - PID 1907 | __metrics Screen width/height:1600/1200 14:35:08 INFO - PID 1907 | colorDepth:24 14:35:08 INFO - PID 1907 | Browser inner width/height: 1024/689 14:35:08 INFO - PID 1907 | __metrics 14:35:08 ERROR - PID 1907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 14:35:08 INFO - PID 1907 | 1491600908290 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:35:09 INFO - TEST-INFO | 1907: exit 0 14:35:09 INFO - Browser initialized. 14:35:09 INFO - Running cycle 1/1 for dromaeo_css test... 14:35:09 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmp3kMHKQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:09 INFO - PID 1910 | 1491600909556 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:35:09 INFO - PID 1910 | 1491600909557 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:35:11 INFO - PID 1910 | 2017-04-07 14:35:11.629 plugin-container[1911:18266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 14:35:11 INFO - PID 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:11 INFO - PID 1910 | 2017-04-07 14:35:11.630 plugin-container[1911:18266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 14:35:11 INFO - PID 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:11 INFO - PID 1910 | 2017-04-07 14:35:11.630 plugin-container[1911:18266] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:35:21 INFO - PID 1910 | RSS: Main: 234532864 14:35:21 INFO - PID 1910 | 14:38:25 INFO - PID 1910 | Cycle 1(1): loaded http://localhost:54242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54242/tests/dromaeo/cssquery-ext.html) 14:38:27 INFO - PID 1910 | RSS: Main: 254005248 14:38:27 INFO - PID 1910 | 14:40:09 INFO - PID 1910 | ************************* 14:40:09 INFO - PID 1910 | A coding exception was thrown and uncaught in a Task. 14:40:09 INFO - PID 1910 | 14:40:09 ERROR - PID 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:09 INFO - PID 1910 | Full stack: 14:40:09 INFO - PID 1910 | ************************* 14:40:09 INFO - PID 1910 | ************************* 14:40:09 INFO - PID 1910 | A coding exception was thrown and uncaught in a Task. 14:40:09 INFO - PID 1910 | 14:40:09 ERROR - PID 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:09 INFO - PID 1910 | Full stack: 14:40:09 INFO - PID 1910 | ************************* 14:40:09 INFO - PID 1910 | ************************* 14:40:09 INFO - PID 1910 | A coding exception was thrown and uncaught in a Task. 14:40:09 INFO - PID 1910 | 14:40:09 ERROR - PID 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:09 INFO - PID 1910 | Full stack: 14:40:09 INFO - PID 1910 | ************************* 14:40:09 INFO - PID 1910 | ************************* 14:40:09 INFO - PID 1910 | A coding exception was thrown and uncaught in a Task. 14:40:09 INFO - PID 1910 | 14:40:09 ERROR - PID 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:09 INFO - PID 1910 | Full stack: 14:40:09 INFO - PID 1910 | ************************* 14:41:29 INFO - PID 1910 | Cycle 1(1): loaded http://localhost:54242/tests/dromaeo/cssquery-ext.html (next: http://localhost:54242/tests/dromaeo/cssquery-jquery.html) 14:41:29 INFO - PID 1910 | RSS: Main: 261165056 14:41:29 INFO - PID 1910 | 14:44:31 INFO - PID 1910 | Cycle 1(1): loaded http://localhost:54242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54242/tests/dromaeo/cssquery-mootools.html) 14:44:31 INFO - PID 1910 | RSS: Main: 273166336 14:44:31 INFO - PID 1910 | 14:47:33 INFO - PID 1910 | Cycle 1(1): loaded http://localhost:54242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54242/tests/dromaeo/cssquery-prototype.html) 14:47:34 INFO - PID 1910 | RSS: Main: 266027008 14:47:34 INFO - PID 1910 | 14:50:37 INFO - PID 1910 | Cycle 1(1): loaded http://localhost:54242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54242/tests/dromaeo/cssquery-yui.html) 14:50:38 INFO - PID 1910 | RSS: Main: 276123648 14:50:38 INFO - PID 1910 | 14:53:39 INFO - PID 1910 | Cycle 1(1): loaded http://localhost:54242/tests/dromaeo/cssquery-yui.html (next: http://localhost:54242/tests/dromaeo/cssquery-dojo.html) 14:53:40 INFO - PID 1910 | RSS: Main: 269385728 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | __start_tp_report 14:53:40 INFO - PID 1910 | _x_x_mozilla_page_load 14:53:40 INFO - PID 1910 | _x_x_mozilla_page_load_details 14:53:40 INFO - PID 1910 | |i|pagename|runs| 14:53:40 INFO - PID 1910 | |0;dojo.html;3564.394053010988;3569.6608822161893;3595.280943811235;3614.8554057837687;3619.819009049547;4597.701149425294;4699.060187962408;5733.569982251327;6032.974394352959;6212.223472065992;5213.765380557884;6233.625982441056;6260.311365749775;6293.622382657032;6300.653464059475;4398.384226208317;5375.731213439332;5495.477929596692;5594.468525490092;5634.239377684001;5598.748056337454;5648.237487939137;5650;5659.745311460973;5669.206311116447;5369.24830523727;5449.373322067933;5466.01611709892;5467.425920278353;5607.663540187581;5457.508824205841;5463.672179669233;5470;5470.452954704538;5480.451954804487;5433.6196466247375;5449.373322067973;5477.726113694339;5515.669059856422;5573.359063707685;5615.887682246373;6185.288691800455;6307.810765677037;6321.6523091229965;6333.651649159295;6035.607685500472;6435.356464353574;6692.665366731692;6722.563033402813;6768.49236307274;6496.870062598721;6631.4031737143405;6723.93276067238;6793.592384456949;6822.761203357908;6328.778492752732;6346.397092276226;6355.0785136155;6356.936430635681;6370.649614271167;6980.092587963633;6987.650617469106;6992.580445173306;6994.405475534637;6997.790066298019;6327.936720632827;6336.8415789604705;6407.135036769976;6569.80290591283;6615.470762339001;6806.149231346082;6809.625470599066;6813.250542440328;6834.863302733917;6860.862782744317;6653.201615806134;6653.733850646016;6716.899246511306;6734.393904548516;6739.59562426256;6438.484921206292;6549.24683661385;6564.409203171737;6703.664816759143;6726.596404215763;5339.546138578186;5382.354117505846;5421.159720243369;5423.023855705932;5423.918641220384;4784.40194975628;4786.16242157621;4788.880277993078;4818.349522814446;4844.903101937942;6170.784022559279;6296.622202667854;6371.936280637227;6376.936230637727;6384.776532821422;6587.110740050032;6683.131192944886;6750.459963202932;6797.456203503708;6846.760363387258;6345.777897773556;6348.1430006949395;6357.141785858942;6367.649779262092;6379.234491861006;5942.851428714231;5979.79070732531;6003.879922401527;6046.969765151146;6060.090986352083;6662.167229096363;6750.628715420699;6824.044633751179;6868.381845633717;6976.407005404496;6813.4889883257965;6829.52193346461;6850.588964661937;6858.5199036067;6881.587104773729;6766.4248538874745;6883.621400823003;6939.687714052779;6943.166819981635;6943.201531823905;6390.392912673288;6471.902921456088;6592.17597800275;6727.260001399744;6749.763758268437;5339.385970613429;6787.694553744995;6826.453883689393;6848.3494068063455;6871.725130994904;6307;6601.53789234749;6604.504662150454;6632.303608121078;6635.966820165868;6333.050042493663;6405.8718825624155;6407.070974708734;6528.738850445929;6592.17597800275;6280.309165991828;6345.936540634534;6444.742210311535;6450.225972883284;6460.095586617971;6545.738170473128;6588;6597.406233439014;6612.933870661232;6620.271770105381;6209.348018457997;6356.9046464304;6380.3619638035825;6443.581167224115;6451.70967306463 14:53:40 INFO - PID 1910 | |1;ext.html;718.0342439418982;793.3494534481725;822.5722624235395;1283.4930202569979;1291.7481091187221;29268.707312926865;37785;37913.24173516531;37944.05139871505;38036.61963380365;37262.813685931535;37590.06024849373;37635.81182094092;37783.05542361436;37799.62200377995;7042.330978557029;8002.51984880909;8166;8754.037055923844;8781.429207101519;8531.74404767858;8549.529775862326;8647.481151130922;8648.178423049832;8655.394122411433;8596.656133754643;8655.610497527627;8679.435836670627;8679.652813887436;8694.17405346491;8589.926259217598;8623.82752344956;8632;8659.004214515347;8660.610272537688;8461.576921153917;8522.659093636246;8526.914730852674;8531.872021919677;8542.572871356408;36859.447108293396;37081.25837483262;37106.8144659275;37132.44301335482;37196.628033719855;3587.157018100744;3629.546306711661;3632;3633.745637805355;3637.5453068366455;29611.259718506994;30068.947586834576;30137.698623013926;30145.698543014507;30168.84915575408;3184.85668144934;3221.7261532769744;3226.451503244454;3227.273863380744;3241.173500757315;197232.05535889202;203868.96131038648;243143;259335.10997335054;261137;43799.56200437955;44161.77919110384;44179.337309940376;44372.11255774867;44394;46214.768926155826;46600;46763.29855052177;46770.766146169735;46857;12920.289384083777;12981.805272920914;13015.023873209548;13036.022298327474;13066.216027038408;10477.47612619366;10653.254272201026;10689.625863094754;10711;10716.732081697864;12774.489020439265;12852.421641026176;12894.67763305925;12902.612921612366;12980.286084265455;4574.588287054181;4949.505049495094;5466.945330546723;5904.697168104442;5907.202527658797;895.4761464543185;948.4262021477045;999.2505620784411;1024.1988162375897;1060.867391576053;21385.930703465077;23071.423214419774;24255.878720606637;24638.384040399134;30049.549256761165;881.8456770065213;1064.707205518473;1066.3069005146563;1099.290957332516;1100.1528822806395;10471.947640261902;11630.941845290889;12192.207506512048;12479.500819967281;12514.687132821753;370214;373815;374065;374199;374909;50979.23531147036;51022.234666480035;51348.45954621367;51348.74325628348;51788.964220715374;1389.9096558723852;1442.9639259018609;1493.2384483913065;1509.3660662521768;1522.2464879884308;20568.69146962767;21868.906554671885;23911.16310929109;23943;23991.880040600383;37997.81001094977;38123.04692382602;38191.61808381881;38314.80842595769;38372.23255534929;346899;348206;348683;348716;348968;30526.236844079074;32679.673203267663;35147.29705405929;35820.462693059104;35963.10092247715;43460.56539434565;44494.55505444904;44669.77665111654;44724.32913506235;44985.550144498135;30066.699333007266;30663.693363066082;30924;31385.52921706222;31652;30257.518190170926;30621.387572248877;30656.846715766278;30983.0705078848;31006.0698179055;36741.63258367382;36854.63145368512;36954.6304536962;36983.63016369802;37081.81459092795;25890.22329330123;30282.84858575693;30810.383792324476;31538.842305788323;31580.684193157773;22722.545549089256;23088.538229234986;23101.65347519755;24499.755002449747;24787.504249915262 14:53:40 INFO - PID 1910 | |2;jquery.html;409.05508275882715;413.96895232857526;419.4463308432866;435.32741913743274;445.4698908299124;20551.38345849625;22211.22260720875;22846.200382986557;22879;22931.42671433215;22341.664875026847;23234.88382558089;23789.762102378972;23816.687073640012;23991.880040599815;6242.469390101847;6322.7154778034865;6473.093766872642;6537.117489138976;6545.836354091138;6258.374162583728;6382.712777925005;6434.099226108348;6441.355864413568;6449.516286278525;6280.811575652715;6298.826904717865;6367.458766004896;6370.108184854124;6412.743490260384;6386.616802991812;6399.328070552595;6424.100625912376;6452.64510451925;6462.773802916875;5478.150886612581;5652.63257888236;5716.857078573027;5726.541876649858;5726.656400615935;27742.167734967985;27848.582271265946;27861.16416507508;27936;28521.286967825763;2287.485315803931;2296.28815067328;2323.453988312745;2340.157543284416;2340.9699732117815;16224.83775162245;18423.355182568546;18533.907330463397;18636;18664.533386665305;1927.469945764912;2181.6400293951638;2198.736151661795;2241.081156725751;2245.10195921631;120913;126270.8432289191;131068.03397949038;131199.68800312065;143856;12441.564545240873;12819;12821.551245706356;12878.67803304925;13000.674983125498;16409.6718065638;16559.83440165607;16638.584035399213;16639.916800416162;16703.91648041752;8388.245057944814;8611.095834937367;8659.177378149066;8744.475331480004;8768.649254029895;7966.920330796618;7989.44073914832;8030.07654119772;8076;8109.310708589718;7993.280604745601;8141.470804397695;8149.025605654012;8151.714689985941;8178.631961561744;2183.3122566391535;2185.5410363823457;2196.7473740519727;2211.9668204976615;2214.6013717531;966.4201479112617;983.2134292566061;992.265723364705;1017.867677201959;1020.9438480883474;20727.067281972348;21702.45743856416;21768.646270745914;21773.564528709336;21813;1001.6944831826363;1023.3910823060268;1033.679559336608;1037.3257382701154;1052.9684109476727;8669.73990780265;11415.315081095161;11465.254758440675;11497.965183133558;11504.194706370474;711303;711607;714176;736250;736631.3168434124;159910;161525;163769;164070;164976;1172.3317708905843;1196.5213914434296;1211.7818792617413;1224.8713885042298;1226.6626677663535;18734.344297949505;18744.906275468536;19095.52261193481;19106.33127840519;19358.225670973003;56831.715841420526;65095.04714858562;65703.34296657164;67361.9895701555;67609.6478070426;65869.67065164643;86497.83755406165;86896;87263;92285;8801.427907186013;8919.241864441336;9170.724878253663;9175.862362064709;9425.57584908667;13350.666233344244;14162.433502660191;14361.497347592784;14493.492727754478;14883.702325953636;11997.64007079789;12113.212641178296;12261.877381226073;12303.630891073282;12373.443195056065;9028.593713282786;10296.691099267035;11599.76800464003;11793.29240245588;12015.939920300343;12085.637430877088;12227.69430764238;12375.62873113808;12424.316662583644;12481.750364992831;8833.69082082124;8834.160754728291;9152.725418237464;9300.6279748812;9306.348555601044;11560.94219528897;12009.939950300193;12180.57367992116;12337.691557711129;12345.876541234473 14:53:40 INFO - PID 1910 | |3;mootools.html;1165.6969188011117;1374.2166964830044;1399.629098288953;1402.2147597345481;1419.042146551078;10056.346337488058;10248.436336001518;11334.263272887256;11841.644750657473;11851.585194518193;11429;11702.648920532398;11834.940825295862;11869.287842729442;11873.16887817853;2502.3493891588137;2523.6971563412326;2535.9746402536016;2539.8222124451204;2540.314115188898;2082.375287413777;2369.7274813396507;2473.938151546208;2492.0405643827166;2496.7128780190237;2136.9849321572283;2423.672804171432;2492.7382624824404;2505.2108585795418;2511.2842839790665;2468.1978357033945;2485.490474452742;2486.6021436570063;2490.9252722418355;2491.825572209946;2433.914812981537;2448.779609835123;2449.2407353720228;2450.2894160693377;2458.176510868861;11784.937635913766;11799;11866.288022718665;11980.940095299555;11991.520339186422;6550.541462097607;6783.6269005204695;6793.898091528631;6794.524383293171;6799.762008329734;4006.9198616027516;4254.127903779718;4315.633171180453;4319.416878721364;4334.631556317717;1056.2078441169124;1234.9444275007647;1299.4412402666849;1305.758434689576;1306.3141850528548;16639.25123369451;16737.832621673748;16763.994160350296;16816;16854.662906741796;5862.325832529228;5955.13650520672;6136.693165341715;6184.288806787187;6235.877542042385;11526.59656912004;14164.291785410689;14173.00788944764;14175.936804739686;14202;6893.20728116263;6898.482613803884;6902.689378977958;6903.344182302673;6909.170899492093;6034.909476357858;6192.195014648067;6235.812925612239;6263.997760358321;6275.02737075754;4392.582704643054;4548.818047278138;4557.1797076526545;4596.724196548218;4599.448066232007;1216.8113942338953;1227.5151315230435;1317.7298653775954;1327.9800802987963;1337.8862796662197;748.356413484403;767.5548182054395;786.944913856036;800.3277247112453;801.6753214947955;5230.424653288135;6790.932090679129;6919.6540172991145;6923.234575183296;6936.306369363124;901.9458832470073;933;943.8961714211431;946.8637634838084;947.9052094790603;4235.597618226264;4239.321708526621;4264.786760662017;4329.76186309756;4340.435743353407;14709.264536773118;15270.541883743283;15278.541643750705;15299.158546280061;15343.386264549294;14439.061461005002;14781.63045923839;15011.924940375227;15047.774283385757;15240.847591524165;10709.518071686793;10961;10973.28673636227;10974.835377469344;11066.889331106586;6006.489448396936;6711.127553418024;7005.754798582026;7027.15674119109;7087.255838136922;13174.341282936006;13290.136141150795;13599.52401665937;13680.179189248278;13720.725585488035;13302;13727.588172354845;13786.793198101836;13805.861941380457;13811.654708632364;9409.952950235478;9527;9616.02871411345;9635.470049147083;9697.272704547046;10639.042486176282;10685.732856678645;10773;10897.073748731447;10900.56397744113;7175.533590316612;9252.028537003518;9299.488528130747;9304.209142222986;9360.017198194091;9009.234215091528;9091.954540227256;9119.817603647758;9152.679656212;9249.768755781159;8226.0540037894;8366.748997530083;8367.07962124178;8368;8391.664333426594;5859.384764599656;6021.909671355021;6038;6147.262328520427;6222.564420490522;6096.725647345968;6119.265688117454;6253.343398943045;6260.561760676709;6408.839779005562 14:53:40 INFO - PID 1910 | |4;prototype.html;362.7623906341346;399.62634936334547;402.2578342957245;413.88825017245324;414.29156142995475;5061.974690126549;5946;6151.263527084143;6184.78353257635;6447.548671592978;5539.224508568794;6232.84417889553;6308.842278943029;6313.032874548955;6393.552451328397;3786.753860999026;4088.0188754698806;4467.597916187542;4549.7725113744345;4601.700889442184;4186.665066794664;4593.26507758757;4601.481511101345;4618.445786505607;4619.006913513594;4581.854536365909;4588.7935042923145;4590.885227869313;4601.171789077965;4613.215753321943;3416.8462419191196;4482.215612267856;4512.9774351128035;4571.748553829538;4609.976950115245;3494.2662040971427;3893.240818040483;3897.707671924617;3900.395438707005;3909.1204478992;4814.301926220678;6140.293866205398;6158.060211033555;6179.598326108833;6449.29093790146;5043.924341134849;5180.456052114511;5261.842144735664;5469.507744302992;5545;5915.822525324247;6784.72861085556;6791.864162716718;6801.319868013208;6802.591844489297;3872.2642697887595;4171.499420069581;4269.380939763748;4506.256467682829;4515.412996310459;6794.660266986681;7024.157101147844;7078.97354883539;7142.535735177197;7187.7843664690145;3961.4748321896277;4579.084183163381;4581.541845815392;4600.125976064537;4607.44710634726;3802.5817160112365;4415.675297410764;4681.227597446451;4681.7190968542;4684.273937539687;5387.111126664135;5464.453554644504;5503.752331145108;5539.806106786324;5550.972245138749;5355.062863998784;6188.762247550418;6549.9345006550275;6822.624755638389;6846.863062738717;1294.9935250323688;1577.7238983177897;1592.808862936432;1595.2422599265255;1599.688255630372;878.7056336127341;1024.446798728693;1041.4844651897208;1047.9991608014327;1053.5522402978704;6450;6455.193100862392;6466.967665161644;6469.77355792545;6479.7408103675325;6700.631465269359;7075.92924070763;7103.538270012433;7119.724926533852;7142.178649455275;5383.650062745909;5683.318001839723;6426.518011149183;6443.420092191725;6459.806205813833;3689.9373519978353;3707.7589956652732;3709.221063576625;3718.888433347004;3724.7206459515646;5998.880022399615;6863.588184708834;7222.858056745333;7269.600171990592;7284.963575182091;5801.345152553864;5848;7008.894866577006;7321.78997076683;7332.78001659951;7071.292870712888;7249.746258880914;7279.59962202084;7285.5264407812265;7286.16209135935;5406.378266499246;6577;7042.6126563039525;7142.750003749844;7169.211386747558;6685.732570697118;6862.656867156722;6906.689198986158;7024.1571011478945;7043.612601306772;5810.360860305278;7128.465365097535;7132.787426137465;7298.708051678086;7319.865420859775;4567.606879901529;4585.358049872953;4590.701604395704;4591.288350305708;4644.2801365788355;6137.3862613738265;6715.7911575916805;7077.079979602619;7083.291670833081;7136.892946605909;6026.578139530367;6459.6447195402825;6856.5200435969;6909.30906909305;7003.54476958996;5669.121286200645;6451.741930322734;6764.729410823512;6853.7943861684225;6880.8967865483055;6726.6636668167375;6730.764423245163;6755.121834161528;6773.864522709419;6791.388775010273;5696.9715151425635;6100.664463454553;6175.722092505758;6878.793636190922;6954.130733658293;6119.3268740437625;6558.868822623616;6611.933880661324;6625.304343043911;6631.933680663132 14:53:40 INFO - PID 1910 | |5;yui.html;823.4647479138555;833.8749187621856;848.4061157189967;869.2220462685897;871.0940621753376;15916.363345466167;17155.056471894055;17156.22796974136;18189.4543163705;18850;17734.201960911756;18153.636927261447;18213.36253231137;18365.265389384444;18453.261869525235;1015.4212099103514;1045.4511381524721;1046.03242001149;1051.4952822645134;1052.0741747262398;1018.1447584029414;1021.6322124035341;1027.3579013116803;1029.382370577655;1029.9742506437324;1091.5961094395045;1093.4478088565263;1095.2333366643343;1098.2751384086505;1101.3557069114538;1076.2466273608427;1083.1172594335592;1088.3687461272443;1089.2974031749477;1091.8525998990153;762.1121393576477;767.4052609227838;772.8686123359042;781.3319611731944;782.4053719173412;16753.91623041877;17081.316747330093;17168.96986180833;17202.827971720373;17212.913935430242;16417.42539011129;16762.83237167625;16965.57586060346;17024.659506809796;17079.743803842826;13565.389557469938;13671.726565468634;13801.723965520634;13931.860681393158;14005.859941400557;3468.3410152071024;3504.5093686883856;3505.4917037029486;3505.509228707983;3510.473428985647;110773.89226107797;118055;118367.81632183654;118936.40531797372;119425;13724.725505490034;13902.16587004783;13954.372053257628;13978.790318145237;13986.790198147037;24373.26880193597;24819.87590062038;25056.624150637756;25364;25409.872950635498;8879.911200888038;9171.63313467454;9203.585838637277;9204.033576474374;9239.90760092404;4447.510773814878;4811.831585894547;4890.877728056756;4906.386701662293;4968.080905032581;4297.54875738043;4333.501647310537;4352.129574085196;4370.519242883281;4376.562343765598;950.5722424908819;970.737900766789;979.6962941488162;986.8322385194534;987.4124895687055;600.7626987339976;608.3004544773457;615.4768446820167;615.7290792051483;632.2476253258608;10141;10629.415382154055;11047.392393418439;11791.174617776845;11881.405929703653;597.979070732531;600.5015836855399;608.6986941464004;613.1232337756961;619.9225096862892;5118.948810511847;5168.586513078944;5203.297554830126;5270.314859068373;5273.235380869829;92156.6176507353;101973;104316.47841760743;105460.41809372866;105725;79431.20568794354;83955.58022209849;85186;85557.28885422257;85791.57104214563;79395;79958.6002069986;80652.38695226063;81708.59145704114;83075.7538636921;11220.326780393203;11784;11848.822267665819;11858.703532411413;12032.398380081137;30336.69663303427;39878.2024359517;40249.79875100723;40937.795311023256;41120.79439602783;53603;68465.31534684589;68854.65572672104;69716.65141674259;70552;14497.492587759378;14593.92703036478;14601;14843.554693359216;14863.405463781328;13778.65553361174;16298.022118672918;16661;17234.741478877575;17240.137993100547;15017.474388396353;15409.614759630651;15473.84526154769;15776.526704198892;15919.522414327126;15102.848971510144;15692;15746.527604171893;15782.974106683028;15888.364465421717;14620.926895365455;15109.47116850905;15312.540623781304;15388.230588470755;15391.61520961985;9843.2125429964;10667.650902271378;10773.946130269298;11067.778644427228;11376.601818936297;11910;12827.871721282667;12970;12994.610161695164;13071.803922941353 14:53:40 INFO - PID 1910 | __end_tp_report 14:53:40 INFO - PID 1910 | __start_cc_report 14:53:40 INFO - PID 1910 | _x_x_mozilla_cycle_collect,433 14:53:40 INFO - PID 1910 | __end_cc_report 14:53:40 INFO - PID 1910 | __startTimestamp1491602020091__endTimestamp 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | ------- Summary: start ------- 14:53:40 INFO - PID 1910 | Number of tests: 6 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | [#0] dojo.html Cycles:165 Average:6164.97 Median:6376.94 stddev:746.75 (11.7%) stddev-sans-first:720.64 14:53:40 INFO - PID 1910 | Values: 3564.4 3569.7 3595.3 3614.9 3619.8 4597.7 4699.1 5733.6 6033.0 6212.2 5213.8 6233.6 6260.3 6293.6 6300.7 4398.4 5375.7 5495.5 5594.5 5634.2 5598.7 5648.2 5650.0 5659.7 5669.2 5369.2 5449.4 5466.0 5467.4 5607.7 5457.5 5463.7 5470.0 5470.5 5480.5 5433.6 5449.4 5477.7 5515.7 5573.4 5615.9 6185.3 6307.8 6321.7 6333.7 6035.6 6435.4 6692.7 6722.6 6768.5 6496.9 6631.4 6723.9 6793.6 6822.8 6328.8 6346.4 6355.1 6356.9 6370.6 6980.1 6987.7 6992.6 6994.4 6997.8 6327.9 6336.8 6407.1 6569.8 6615.5 6806.1 6809.6 6813.3 6834.9 6860.9 6653.2 6653.7 6716.9 6734.4 6739.6 6438.5 6549.2 6564.4 6703.7 6726.6 5339.5 5382.4 5421.2 5423.0 5423.9 4784.4 4786.2 4788.9 4818.3 4844.9 6170.8 6296.6 6371.9 6376.9 6384.8 6587.1 6683.1 6750.5 6797.5 6846.8 6345.8 6348.1 6357.1 6367.6 6379.2 5942.9 5979.8 6003.9 6047.0 6060.1 6662.2 6750.6 6824.0 6868.4 6976.4 6813.5 6829.5 6850.6 6858.5 6881.6 6766.4 6883.6 6939.7 6943.2 6943.2 6390.4 6471.9 6592.2 6727.3 6749.8 5339.4 6787.7 6826.5 6848.3 6871.7 6307.0 6601.5 6604.5 6632.3 6636.0 6333.1 6405.9 6407.1 6528.7 6592.2 6280.3 6345.9 6444.7 6450.2 6460.1 6545.7 6588.0 6597.4 6612.9 6620.3 6209.3 6356.9 6380.4 6443.6 6451.7 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | [#1] ext.html Cycles:180 Average:46161.33 Median:3630.77 stddev:85599.56 (2357.6%) stddev-sans-first:85771.69 14:53:40 INFO - PID 1910 | Values: 718.0 793.3 822.6 1283.5 1291.7 29268.7 37785.0 37913.2 37944.1 38036.6 37262.8 37590.1 37635.8 37783.1 37799.6 7042.3 8002.5 8166.0 8754.0 8781.4 8531.7 8549.5 8647.5 8648.2 8655.4 8596.7 8655.6 8679.4 8679.7 8694.2 8589.9 8623.8 8632.0 8659.0 8660.6 8461.6 8522.7 8526.9 8531.9 8542.6 36859.4 37081.3 37106.8 37132.4 37196.6 3587.2 3629.5 3632.0 3633.7 3637.5 29611.3 30068.9 30137.7 30145.7 30168.8 3184.9 3221.7 3226.5 3227.3 3241.2 197232.1 203869.0 243143.0 259335.1 261137.0 43799.6 44161.8 44179.3 44372.1 44394.0 46214.8 46600.0 46763.3 46770.8 46857.0 12920.3 12981.8 13015.0 13036.0 13066.2 10477.5 10653.3 10689.6 10711.0 10716.7 12774.5 12852.4 12894.7 12902.6 12980.3 4574.6 4949.5 5466.9 5904.7 5907.2 895.5 948.4 999.3 1024.2 1060.9 21385.9 23071.4 24255.9 24638.4 30049.5 881.8 1064.7 1066.3 1099.3 1100.2 10471.9 11630.9 12192.2 12479.5 12514.7 370214.0 373815.0 374065.0 374199.0 374909.0 50979.2 51022.2 51348.5 51348.7 51789.0 1389.9 1443.0 1493.2 1509.4 1522.2 20568.7 21868.9 23911.2 23943.0 23991.9 37997.8 38123.0 38191.6 38314.8 38372.2 346899.0 348206.0 348683.0 348716.0 348968.0 30526.2 32679.7 35147.3 35820.5 35963.1 43460.6 44494.6 44669.8 44724.3 44985.6 30066.7 30663.7 30924.0 31385.5 31652.0 30257.5 30621.4 30656.8 30983.1 31006.1 36741.6 36854.6 36954.6 36983.6 37081.8 25890.2 30282.8 30810.4 31538.8 31580.7 22722.5 23088.5 23101.7 24499.8 24787.5 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | [#2] jquery.html Cycles:180 Average:41189.23 Median:22905.21 stddev:120540.21 (526.3%) stddev-sans-first:120839.47 14:53:40 INFO - PID 1910 | Values: 409.1 414.0 419.4 435.3 445.5 20551.4 22211.2 22846.2 22879.0 22931.4 22341.7 23234.9 23789.8 23816.7 23991.9 6242.5 6322.7 6473.1 6537.1 6545.8 6258.4 6382.7 6434.1 6441.4 6449.5 6280.8 6298.8 6367.5 6370.1 6412.7 6386.6 6399.3 6424.1 6452.6 6462.8 5478.2 5652.6 5716.9 5726.5 5726.7 27742.2 27848.6 27861.2 27936.0 28521.3 2287.5 2296.3 2323.5 2340.2 2341.0 16224.8 18423.4 18533.9 18636.0 18664.5 1927.5 2181.6 2198.7 2241.1 2245.1 120913.0 126270.8 131068.0 131199.7 143856.0 12441.6 12819.0 12821.6 12878.7 13000.7 16409.7 16559.8 16638.6 16639.9 16703.9 8388.2 8611.1 8659.2 8744.5 8768.6 7966.9 7989.4 8030.1 8076.0 8109.3 7993.3 8141.5 8149.0 8151.7 8178.6 2183.3 2185.5 2196.7 2212.0 2214.6 966.4 983.2 992.3 1017.9 1020.9 20727.1 21702.5 21768.6 21773.6 21813.0 1001.7 1023.4 1033.7 1037.3 1053.0 8669.7 11415.3 11465.3 11498.0 11504.2 711303.0 711607.0 714176.0 736250.0 736631.3 159910.0 161525.0 163769.0 164070.0 164976.0 1172.3 1196.5 1211.8 1224.9 1226.7 18734.3 18744.9 19095.5 19106.3 19358.2 56831.7 65095.0 65703.3 67362.0 67609.6 65869.7 86497.8 86896.0 87263.0 92285.0 8801.4 8919.2 9170.7 9175.9 9425.6 13350.7 14162.4 14361.5 14493.5 14883.7 11997.6 12113.2 12261.9 12303.6 12373.4 9028.6 10296.7 11599.8 11793.3 12015.9 12085.6 12227.7 12375.6 12424.3 12481.8 8833.7 8834.2 9152.7 9300.6 9306.3 11560.9 12009.9 12180.6 12337.7 12345.9 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | [#3] mootools.html Cycles:180 Average:7290.59 Median:2517.49 stddev:4626.75 (183.8%) stddev-sans-first:4616.83 14:53:40 INFO - PID 1910 | Values: 1165.7 1374.2 1399.6 1402.2 1419.0 10056.3 10248.4 11334.3 11841.6 11851.6 11429.0 11702.6 11834.9 11869.3 11873.2 2502.3 2523.7 2536.0 2539.8 2540.3 2082.4 2369.7 2473.9 2492.0 2496.7 2137.0 2423.7 2492.7 2505.2 2511.3 2468.2 2485.5 2486.6 2490.9 2491.8 2433.9 2448.8 2449.2 2450.3 2458.2 11784.9 11799.0 11866.3 11980.9 11991.5 6550.5 6783.6 6793.9 6794.5 6799.8 4006.9 4254.1 4315.6 4319.4 4334.6 1056.2 1234.9 1299.4 1305.8 1306.3 16639.3 16737.8 16764.0 16816.0 16854.7 5862.3 5955.1 6136.7 6184.3 6235.9 11526.6 14164.3 14173.0 14175.9 14202.0 6893.2 6898.5 6902.7 6903.3 6909.2 6034.9 6192.2 6235.8 6264.0 6275.0 4392.6 4548.8 4557.2 4596.7 4599.4 1216.8 1227.5 1317.7 1328.0 1337.9 748.4 767.6 786.9 800.3 801.7 5230.4 6790.9 6919.7 6923.2 6936.3 901.9 933.0 943.9 946.9 947.9 4235.6 4239.3 4264.8 4329.8 4340.4 14709.3 15270.5 15278.5 15299.2 15343.4 14439.1 14781.6 15011.9 15047.8 15240.8 10709.5 10961.0 10973.3 10974.8 11066.9 6006.5 6711.1 7005.8 7027.2 7087.3 13174.3 13290.1 13599.5 13680.2 13720.7 13302.0 13727.6 13786.8 13805.9 13811.7 9410.0 9527.0 9616.0 9635.5 9697.3 10639.0 10685.7 10773.0 10897.1 10900.6 7175.5 9252.0 9299.5 9304.2 9360.0 9009.2 9092.0 9119.8 9152.7 9249.8 8226.1 8366.7 8367.1 8368.0 8391.7 5859.4 6021.9 6038.0 6147.3 6222.6 6096.7 6119.3 6253.3 6260.6 6408.8 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | [#4] prototype.html Cycles:180 Average:5427.70 Median:6110.00 stddev:1747.20 (28.6%) stddev-sans-first:1710.24 14:53:40 INFO - PID 1910 | Values: 362.8 399.6 402.3 413.9 414.3 5062.0 5946.0 6151.3 6184.8 6447.5 5539.2 6232.8 6308.8 6313.0 6393.6 3786.8 4088.0 4467.6 4549.8 4601.7 4186.7 4593.3 4601.5 4618.4 4619.0 4581.9 4588.8 4590.9 4601.2 4613.2 3416.8 4482.2 4513.0 4571.7 4610.0 3494.3 3893.2 3897.7 3900.4 3909.1 4814.3 6140.3 6158.1 6179.6 6449.3 5043.9 5180.5 5261.8 5469.5 5545.0 5915.8 6784.7 6791.9 6801.3 6802.6 3872.3 4171.5 4269.4 4506.3 4515.4 6794.7 7024.2 7079.0 7142.5 7187.8 3961.5 4579.1 4581.5 4600.1 4607.4 3802.6 4415.7 4681.2 4681.7 4684.3 5387.1 5464.5 5503.8 5539.8 5551.0 5355.1 6188.8 6549.9 6822.6 6846.9 1295.0 1577.7 1592.8 1595.2 1599.7 878.7 1024.4 1041.5 1048.0 1053.6 6450.0 6455.2 6467.0 6469.8 6479.7 6700.6 7075.9 7103.5 7119.7 7142.2 5383.7 5683.3 6426.5 6443.4 6459.8 3689.9 3707.8 3709.2 3718.9 3724.7 5998.9 6863.6 7222.9 7269.6 7285.0 5801.3 5848.0 7008.9 7321.8 7332.8 7071.3 7249.7 7279.6 7285.5 7286.2 5406.4 6577.0 7042.6 7142.8 7169.2 6685.7 6862.7 6906.7 7024.2 7043.6 5810.4 7128.5 7132.8 7298.7 7319.9 4567.6 4585.4 4590.7 4591.3 4644.3 6137.4 6715.8 7077.1 7083.3 7136.9 6026.6 6459.6 6856.5 6909.3 7003.5 5669.1 6451.7 6764.7 6853.8 6880.9 6726.7 6730.8 6755.1 6773.9 6791.4 5697.0 6100.7 6175.7 6878.8 6954.1 6119.3 6558.9 6611.9 6625.3 6631.9 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | [#5] yui.html Cycles:180 Average:21379.62 Median:17162.60 stddev:29596.02 (172.4%) stddev-sans-first:29638.79 14:53:40 INFO - PID 1910 | Values: 823.5 833.9 848.4 869.2 871.1 15916.4 17155.1 17156.2 18189.5 18850.0 17734.2 18153.6 18213.4 18365.3 18453.3 1015.4 1045.5 1046.0 1051.5 1052.1 1018.1 1021.6 1027.4 1029.4 1030.0 1091.6 1093.4 1095.2 1098.3 1101.4 1076.2 1083.1 1088.4 1089.3 1091.9 762.1 767.4 772.9 781.3 782.4 16753.9 17081.3 17169.0 17202.8 17212.9 16417.4 16762.8 16965.6 17024.7 17079.7 13565.4 13671.7 13801.7 13931.9 14005.9 3468.3 3504.5 3505.5 3505.5 3510.5 110773.9 118055.0 118367.8 118936.4 119425.0 13724.7 13902.2 13954.4 13978.8 13986.8 24373.3 24819.9 25056.6 25364.0 25409.9 8879.9 9171.6 9203.6 9204.0 9239.9 4447.5 4811.8 4890.9 4906.4 4968.1 4297.5 4333.5 4352.1 4370.5 4376.6 950.6 970.7 979.7 986.8 987.4 600.8 608.3 615.5 615.7 632.2 10141.0 10629.4 11047.4 11791.2 11881.4 598.0 600.5 608.7 613.1 619.9 5118.9 5168.6 5203.3 5270.3 5273.2 92156.6 101973.0 104316.5 105460.4 105725.0 79431.2 83955.6 85186.0 85557.3 85791.6 79395.0 79958.6 80652.4 81708.6 83075.8 11220.3 11784.0 11848.8 11858.7 12032.4 30336.7 39878.2 40249.8 40937.8 41120.8 53603.0 68465.3 68854.7 69716.7 70552.0 14497.5 14593.9 14601.0 14843.6 14863.4 13778.7 16298.0 16661.0 17234.7 17240.1 15017.5 15409.6 15473.8 15776.5 15919.5 15102.8 15692.0 15746.5 15783.0 15888.4 14620.9 15109.5 15312.5 15388.2 15391.6 9843.2 10667.7 10773.9 11067.8 11376.6 11910.0 12827.9 12970.0 12994.6 13071.8 14:53:40 INFO - PID 1910 | -------- Summary: end -------- 14:53:40 INFO - PID 1910 | 14:53:40 INFO - PID 1910 | 1491602020120 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:53:40 INFO - TEST-INFO | 1910: exit 0 14:53:40 INFO - TEST-OK | dromaeo_css | took 1115641ms 14:53:40 INFO - TEST-START | kraken 14:53:40 INFO - operating with platform_type : mac_ 14:53:40 INFO - Initialising browser for kraken test... 14:53:40 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpfwdaOD/profile http://localhost:54242/getInfo.html) 14:53:41 INFO - PID 1916 | 1491602021332 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:53:41 INFO - PID 1916 | 1491602021333 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method install 14:53:41 INFO - PID 1916 | 1491602021384 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:53:43 INFO - PID 1916 | 2017-04-07 14:53:43.609 plugin-container[1917:20378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 14:53:43 INFO - PID 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:53:43 INFO - PID 1916 | 2017-04-07 14:53:43.612 plugin-container[1917:20378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 14:53:43 INFO - PID 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:53:43 INFO - PID 1916 | 2017-04-07 14:53:43.612 plugin-container[1917:20378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:53:43 INFO - PID 1916 | __metrics Screen width/height:1600/1200 14:53:43 INFO - PID 1916 | colorDepth:24 14:53:43 INFO - PID 1916 | Browser inner width/height: 1024/689 14:53:43 INFO - PID 1916 | __metrics 14:53:43 ERROR - PID 1916 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 14:53:43 INFO - PID 1916 | 1491602023832 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:53:44 INFO - TEST-INFO | 1916: exit 0 14:53:44 INFO - Browser initialized. 14:53:44 INFO - Running cycle 1/1 for kraken test... 14:53:44 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpfwdaOD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:45 INFO - PID 1918 | 1491602025311 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:53:45 INFO - PID 1918 | 1491602025313 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:53:47 INFO - PID 1918 | 2017-04-07 14:53:47.308 plugin-container[1919:20504] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 14:53:47 INFO - PID 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:53:47 INFO - PID 1918 | 2017-04-07 14:53:47.309 plugin-container[1919:20504] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:53:47 INFO - PID 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:53:47 INFO - PID 1918 | 2017-04-07 14:53:47.309 plugin-container[1919:20504] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:53:57 INFO - PID 1918 | RSS: Main: 233467904 14:53:57 INFO - PID 1918 | 14:54:00 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54242/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:01 INFO - PID 1918 | RSS: Main: 248393728 14:54:01 INFO - PID 1918 | 14:54:03 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54242/tests/kraken/driver.html?testName=audio-dft) 14:54:04 INFO - PID 1918 | RSS: Main: 257015808 14:54:04 INFO - PID 1918 | 14:54:08 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54242/tests/kraken/driver.html?testName=audio-fft) 14:54:09 INFO - PID 1918 | RSS: Main: 259235840 14:54:09 INFO - PID 1918 | 14:54:11 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54242/tests/kraken/driver.html?testName=audio-oscillator) 14:54:11 INFO - PID 1918 | RSS: Main: 261271552 14:54:11 INFO - PID 1918 | 14:54:13 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:14 INFO - PID 1918 | RSS: Main: 261849088 14:54:14 INFO - PID 1918 | 14:54:17 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54242/tests/kraken/driver.html?testName=imaging-darkroom) 14:54:18 INFO - PID 1918 | RSS: Main: 267149312 14:54:18 INFO - PID 1918 | 14:54:21 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54242/tests/kraken/driver.html?testName=imaging-desaturate) 14:54:22 INFO - PID 1918 | RSS: Main: 267685888 14:54:22 INFO - PID 1918 | 14:54:25 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54242/tests/kraken/driver.html?testName=json-parse-financial) 14:54:26 INFO - PID 1918 | RSS: Main: 264835072 14:54:26 INFO - PID 1918 | 14:54:27 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:28 INFO - PID 1918 | RSS: Main: 266100736 14:54:28 INFO - PID 1918 | 14:54:30 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:31 INFO - PID 1918 | RSS: Main: 266694656 14:54:31 INFO - PID 1918 | 14:54:33 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:34 INFO - PID 1918 | RSS: Main: 266543104 14:54:34 INFO - PID 1918 | 14:54:37 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:54:38 INFO - PID 1918 | RSS: Main: 266883072 14:54:38 INFO - PID 1918 | 14:54:41 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:54:42 INFO - PID 1918 | RSS: Main: 265535488 14:54:42 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:54242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54242/tests/kraken/driver.html?testName=ai-astar) 14:54:44 INFO - PID 1918 | RSS: Main: 268873728 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | __start_tp_report 14:54:44 INFO - PID 1918 | _x_x_mozilla_page_load 14:54:44 INFO - PID 1918 | _x_x_mozilla_page_load_details 14:54:44 INFO - PID 1918 | |i|pagename|runs| 14:54:44 INFO - PID 1918 | |0;ai-astar;109;122;123;114;121;184;183;121;122;124 14:54:44 INFO - PID 1918 | |1;audio-beat-detection;161;111;116;173;148;149;118;140;181;143 14:54:44 INFO - PID 1918 | |2;audio-dft;224;237;283;293;316;243;213;211;215;210 14:54:44 INFO - PID 1918 | |3;audio-fft;76;91;66;91;65;62;74;60;74;51 14:54:44 INFO - PID 1918 | |4;audio-oscillator;87;71;88;64;67;72;86;70;72;98 14:54:44 INFO - PID 1918 | |5;imaging-gaussian-blur;93;91;104;105;117;90;142;141;93;94 14:54:44 INFO - PID 1918 | |6;imaging-darkroom;103;102;102;101;101;123;164;102;100;104 14:54:44 INFO - PID 1918 | |7;imaging-desaturate;102;139;162;111;164;160;104;99;162;121 14:54:44 INFO - PID 1918 | |8;json-parse-financial;52;54;53;53;53;57;52;56;54;50 14:54:44 INFO - PID 1918 | |9;json-stringify-tinderbox;61;58;71;68;66;49;85;91;89;91 14:54:44 INFO - PID 1918 | |10;stanford-crypto-aes;87;86;90;85;101;88;89;87;87;88 14:54:44 INFO - PID 1918 | |11;stanford-crypto-ccm;157;176;154;168;163;149;179;173;225;230 14:54:44 INFO - PID 1918 | |12;stanford-crypto-pbkdf2;189;267;254;210;255;212;217;228;259;240 14:54:44 INFO - PID 1918 | |13;stanford-crypto-sha256-iterative;67;100;60;88;102;103;69;74;100;111 14:54:44 INFO - PID 1918 | __end_tp_report 14:54:44 INFO - PID 1918 | __start_cc_report 14:54:44 INFO - PID 1918 | _x_x_mozilla_cycle_collect,1037 14:54:44 INFO - PID 1918 | __end_cc_report 14:54:44 INFO - PID 1918 | __startTimestamp1491602084644__endTimestamp 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | ------- Summary: start ------- 14:54:44 INFO - PID 1918 | Number of tests: 14 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#0] ai-astar Cycles:10 Average:132.30 Median:122.50 stddev:27.37 (22.3%) stddev-sans-first:27.71 14:54:44 INFO - PID 1918 | Values: 109.0 122.0 123.0 114.0 121.0 184.0 183.0 121.0 122.0 124.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:148.50 stddev:23.82 (16.0%) stddev-sans-first:24.46 14:54:44 INFO - PID 1918 | Values: 161.0 111.0 116.0 173.0 148.0 149.0 118.0 140.0 181.0 143.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#2] audio-dft Cycles:10 Average:244.50 Median:240.00 stddev:38.87 (16.2%) stddev-sans-first:40.52 14:54:44 INFO - PID 1918 | Values: 224.0 237.0 283.0 293.0 316.0 243.0 213.0 211.0 215.0 210.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#3] audio-fft Cycles:10 Average:71.00 Median:74.00 stddev:12.94 (17.5%) stddev-sans-first:13.59 14:54:44 INFO - PID 1918 | Values: 76.0 91.0 66.0 91.0 65.0 62.0 74.0 60.0 74.0 51.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.00 stddev:11.28 (14.3%) stddev-sans-first:11.42 14:54:44 INFO - PID 1918 | Values: 87.0 71.0 88.0 64.0 67.0 72.0 86.0 70.0 72.0 98.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#5] imaging-gaussian-blur Cycles:10 Average:107.00 Median:90.50 stddev:20.00 (22.1%) stddev-sans-first:20.56 14:54:44 INFO - PID 1918 | Values: 93.0 91.0 104.0 105.0 117.0 90.0 142.0 141.0 93.0 94.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#6] imaging-darkroom Cycles:10 Average:110.20 Median:102.50 stddev:20.07 (19.6%) stddev-sans-first:21.11 14:54:44 INFO - PID 1918 | Values: 103.0 102.0 102.0 101.0 101.0 123.0 164.0 102.0 100.0 104.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#7] imaging-desaturate Cycles:10 Average:132.40 Median:161.00 stddev:27.87 (17.3%) stddev-sans-first:27.30 14:54:44 INFO - PID 1918 | Values: 102.0 139.0 162.0 111.0 164.0 160.0 104.0 99.0 162.0 121.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:2.01 (3.8%) stddev-sans-first:2.07 14:54:44 INFO - PID 1918 | Values: 52.0 54.0 53.0 53.0 53.0 57.0 52.0 56.0 54.0 50.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:78.00 stddev:15.17 (19.4%) stddev-sans-first:15.47 14:54:44 INFO - PID 1918 | Values: 61.0 58.0 71.0 68.0 66.0 49.0 85.0 91.0 89.0 91.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:87.50 stddev:4.52 (5.2%) stddev-sans-first:4.74 14:54:44 INFO - PID 1918 | Values: 87.0 86.0 90.0 85.0 101.0 88.0 89.0 87.0 87.0 88.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#11] stanford-crypto-ccm Cycles:10 Average:177.40 Median:174.50 stddev:28.13 (16.1%) stddev-sans-first:28.85 14:54:44 INFO - PID 1918 | Values: 157.0 176.0 154.0 168.0 163.0 149.0 179.0 173.0 225.0 230.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:233.10 Median:247.00 stddev:25.80 (10.4%) stddev-sans-first:21.89 14:54:44 INFO - PID 1918 | Values: 189.0 267.0 254.0 210.0 255.0 212.0 217.0 228.0 259.0 240.0 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.40 Median:63.50 stddev:18.31 (28.8%) stddev-sans-first:17.87 14:54:44 INFO - PID 1918 | Values: 67.0 100.0 60.0 88.0 102.0 103.0 69.0 74.0 100.0 111.0 14:54:44 INFO - PID 1918 | -------- Summary: end -------- 14:54:44 INFO - PID 1918 | 14:54:44 INFO - PID 1918 | 1491602084670 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:54:45 INFO - TEST-INFO | 1918: exit 0 14:54:45 INFO - TEST-OK | kraken | took 64983ms 14:54:45 INFO - SUITE-END | took 1180s 14:54:45 INFO - Completed test suite (00:19:40) 14:54:45 INFO - javascript benchmark 14:54:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7958.6050621345075, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3564.394053010988, 3569.6608822161893, 3595.280943811235, 3614.8554057837687, 3619.819009049547, 4597.701149425294, 4699.060187962408, 5733.569982251327, 6032.974394352959, 6212.223472065992, 5213.765380557884, 6233.625982441056, 6260.311365749775, 6293.622382657032, 6300.653464059475, 4398.384226208317, 5375.731213439332, 5495.477929596692, 5594.468525490092, 5634.239377684001, 5598.748056337454, 5648.237487939137, 5650.0, 5659.745311460973, 5669.206311116447, 5369.24830523727, 5449.373322067933, 5466.01611709892, 5467.425920278353, 5607.663540187581, 5457.508824205841, 5463.672179669233, 5470.0, 5470.452954704538, 5480.451954804487, 5433.6196466247375, 5449.373322067973, 5477.726113694339, 5515.669059856422, 5573.359063707685, 5615.887682246373, 6185.288691800455, 6307.810765677037, 6321.6523091229965, 6333.651649159295, 6035.607685500472, 6435.356464353574, 6692.665366731692, 6722.563033402813, 6768.49236307274, 6496.870062598721, 6631.4031737143405, 6723.93276067238, 6793.592384456949, 6822.761203357908, 6328.778492752732, 6346.397092276226, 6355.0785136155, 6356.936430635681, 6370.649614271167, 6980.092587963633, 6987.650617469106, 6992.580445173306, 6994.405475534637, 6997.790066298019, 6327.936720632827, 6336.8415789604705, 6407.135036769976, 6569.80290591283, 6615.470762339001, 6806.149231346082, 6809.625470599066, 6813.250542440328, 6834.863302733917, 6860.862782744317, 6653.201615806134, 6653.733850646016, 6716.899246511306, 6734.393904548516, 6739.59562426256, 6438.484921206292, 6549.24683661385, 6564.409203171737, 6703.664816759143, 6726.596404215763, 5339.546138578186, 5382.354117505846, 5421.159720243369, 5423.023855705932, 5423.918641220384, 4784.40194975628, 4786.16242157621, 4788.880277993078, 4818.349522814446, 4844.903101937942, 6170.784022559279, 6296.622202667854, 6371.936280637227, 6376.936230637727, 6384.776532821422, 6587.110740050032, 6683.131192944886, 6750.459963202932, 6797.456203503708, 6846.760363387258, 6345.777897773556, 6348.1430006949395, 6357.141785858942, 6367.649779262092, 6379.234491861006, 5942.851428714231, 5979.79070732531, 6003.879922401527, 6046.969765151146, 6060.090986352083, 6662.167229096363, 6750.628715420699, 6824.044633751179, 6868.381845633717, 6976.407005404496, 6813.4889883257965, 6829.52193346461, 6850.588964661937, 6858.5199036067, 6881.587104773729, 6766.4248538874745, 6883.621400823003, 6939.687714052779, 6943.166819981635, 6943.201531823905, 6390.392912673288, 6471.902921456088, 6592.17597800275, 6727.260001399744, 6749.763758268437, 5339.385970613429, 6787.694553744995, 6826.453883689393, 6848.3494068063455, 6871.725130994904, 6307.0, 6601.53789234749, 6604.504662150454, 6632.303608121078, 6635.966820165868, 6333.050042493663, 6405.8718825624155, 6407.070974708734, 6528.738850445929, 6592.17597800275, 6280.309165991828, 6345.936540634534, 6444.742210311535, 6450.225972883284, 6460.095586617971, 6545.738170473128, 6588.0, 6597.406233439014, 6612.933870661232, 6620.271770105381, 6209.348018457997, 6356.9046464304, 6380.3619638035825, 6443.581167224115, 6451.70967306463], "value": 6116.371098406448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.0342439418982, 793.3494534481725, 822.5722624235395, 1283.4930202569979, 1291.7481091187221, 29268.707312926865, 37785.0, 37913.24173516531, 37944.05139871505, 38036.61963380365, 37262.813685931535, 37590.06024849373, 37635.81182094092, 37783.05542361436, 37799.62200377995, 7042.330978557029, 8002.51984880909, 8166.0, 8754.037055923844, 8781.429207101519, 8531.74404767858, 8549.529775862326, 8647.481151130922, 8648.178423049832, 8655.394122411433, 8596.656133754643, 8655.610497527627, 8679.435836670627, 8679.652813887436, 8694.17405346491, 8589.926259217598, 8623.82752344956, 8632.0, 8659.004214515347, 8660.610272537688, 8461.576921153917, 8522.659093636246, 8526.914730852674, 8531.872021919677, 8542.572871356408, 36859.447108293396, 37081.25837483262, 37106.8144659275, 37132.44301335482, 37196.628033719855, 3587.157018100744, 3629.546306711661, 3632.0, 3633.745637805355, 3637.5453068366455, 29611.259718506994, 30068.947586834576, 30137.698623013926, 30145.698543014507, 30168.84915575408, 3184.85668144934, 3221.7261532769744, 3226.451503244454, 3227.273863380744, 3241.173500757315, 197232.05535889202, 203868.96131038648, 243143.0, 259335.10997335054, 261137.0, 43799.56200437955, 44161.77919110384, 44179.337309940376, 44372.11255774867, 44394.0, 46214.768926155826, 46600.0, 46763.29855052177, 46770.766146169735, 46857.0, 12920.289384083777, 12981.805272920914, 13015.023873209548, 13036.022298327474, 13066.216027038408, 10477.47612619366, 10653.254272201026, 10689.625863094754, 10711.0, 10716.732081697864, 12774.489020439265, 12852.421641026176, 12894.67763305925, 12902.612921612366, 12980.286084265455, 4574.588287054181, 4949.505049495094, 5466.945330546723, 5904.697168104442, 5907.202527658797, 895.4761464543185, 948.4262021477045, 999.2505620784411, 1024.1988162375897, 1060.867391576053, 21385.930703465077, 23071.423214419774, 24255.878720606637, 24638.384040399134, 30049.549256761165, 881.8456770065213, 1064.707205518473, 1066.3069005146563, 1099.290957332516, 1100.1528822806395, 10471.947640261902, 11630.941845290889, 12192.207506512048, 12479.500819967281, 12514.687132821753, 370214.0, 373815.0, 374065.0, 374199.0, 374909.0, 50979.23531147036, 51022.234666480035, 51348.45954621367, 51348.74325628348, 51788.964220715374, 1389.9096558723852, 1442.9639259018609, 1493.2384483913065, 1509.3660662521768, 1522.2464879884308, 20568.69146962767, 21868.906554671885, 23911.16310929109, 23943.0, 23991.880040600383, 37997.81001094977, 38123.04692382602, 38191.61808381881, 38314.80842595769, 38372.23255534929, 346899.0, 348206.0, 348683.0, 348716.0, 348968.0, 30526.236844079074, 32679.673203267663, 35147.29705405929, 35820.462693059104, 35963.10092247715, 43460.56539434565, 44494.55505444904, 44669.77665111654, 44724.32913506235, 44985.550144498135, 30066.699333007266, 30663.693363066082, 30924.0, 31385.52921706222, 31652.0, 30257.518190170926, 30621.387572248877, 30656.846715766278, 30983.0705078848, 31006.0698179055, 36741.63258367382, 36854.63145368512, 36954.6304536962, 36983.63016369802, 37081.81459092795, 25890.22329330123, 30282.84858575693, 30810.383792324476, 31538.842305788323, 31580.684193157773, 22722.545549089256, 23088.538229234986, 23101.65347519755, 24499.755002449747, 24787.504249915262], "value": 17267.526527390906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.05508275882715, 413.96895232857526, 419.4463308432866, 435.32741913743274, 445.4698908299124, 20551.38345849625, 22211.22260720875, 22846.200382986557, 22879.0, 22931.42671433215, 22341.664875026847, 23234.88382558089, 23789.762102378972, 23816.687073640012, 23991.880040599815, 6242.469390101847, 6322.7154778034865, 6473.093766872642, 6537.117489138976, 6545.836354091138, 6258.374162583728, 6382.712777925005, 6434.099226108348, 6441.355864413568, 6449.516286278525, 6280.811575652715, 6298.826904717865, 6367.458766004896, 6370.108184854124, 6412.743490260384, 6386.616802991812, 6399.328070552595, 6424.100625912376, 6452.64510451925, 6462.773802916875, 5478.150886612581, 5652.63257888236, 5716.857078573027, 5726.541876649858, 5726.656400615935, 27742.167734967985, 27848.582271265946, 27861.16416507508, 27936.0, 28521.286967825763, 2287.485315803931, 2296.28815067328, 2323.453988312745, 2340.157543284416, 2340.9699732117815, 16224.83775162245, 18423.355182568546, 18533.907330463397, 18636.0, 18664.533386665305, 1927.469945764912, 2181.6400293951638, 2198.736151661795, 2241.081156725751, 2245.10195921631, 120913.0, 126270.8432289191, 131068.03397949038, 131199.68800312065, 143856.0, 12441.564545240873, 12819.0, 12821.551245706356, 12878.67803304925, 13000.674983125498, 16409.6718065638, 16559.83440165607, 16638.584035399213, 16639.916800416162, 16703.91648041752, 8388.245057944814, 8611.095834937367, 8659.177378149066, 8744.475331480004, 8768.649254029895, 7966.920330796618, 7989.44073914832, 8030.07654119772, 8076.0, 8109.310708589718, 7993.280604745601, 8141.470804397695, 8149.025605654012, 8151.714689985941, 8178.631961561744, 2183.3122566391535, 2185.5410363823457, 2196.7473740519727, 2211.9668204976615, 2214.6013717531, 966.4201479112617, 983.2134292566061, 992.265723364705, 1017.867677201959, 1020.9438480883474, 20727.067281972348, 21702.45743856416, 21768.646270745914, 21773.564528709336, 21813.0, 1001.6944831826363, 1023.3910823060268, 1033.679559336608, 1037.3257382701154, 1052.9684109476727, 8669.73990780265, 11415.315081095161, 11465.254758440675, 11497.965183133558, 11504.194706370474, 711303.0, 711607.0, 714176.0, 736250.0, 736631.3168434124, 159910.0, 161525.0, 163769.0, 164070.0, 164976.0, 1172.3317708905843, 1196.5213914434296, 1211.7818792617413, 1224.8713885042298, 1226.6626677663535, 18734.344297949505, 18744.906275468536, 19095.52261193481, 19106.33127840519, 19358.225670973003, 56831.715841420526, 65095.04714858562, 65703.34296657164, 67361.9895701555, 67609.6478070426, 65869.67065164643, 86497.83755406165, 86896.0, 87263.0, 92285.0, 8801.427907186013, 8919.241864441336, 9170.724878253663, 9175.862362064709, 9425.57584908667, 13350.666233344244, 14162.433502660191, 14361.497347592784, 14493.492727754478, 14883.702325953636, 11997.64007079789, 12113.212641178296, 12261.877381226073, 12303.630891073282, 12373.443195056065, 9028.593713282786, 10296.691099267035, 11599.76800464003, 11793.29240245588, 12015.939920300343, 12085.637430877088, 12227.69430764238, 12375.62873113808, 12424.316662583644, 12481.750364992831, 8833.69082082124, 8834.160754728291, 9152.725418237464, 9300.6279748812, 9306.348555601044, 11560.94219528897, 12009.939950300193, 12180.57367992116, 12337.691557711129, 12345.876541234473], "value": 10784.486258170647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1165.6969188011117, 1374.2166964830044, 1399.629098288953, 1402.2147597345481, 1419.042146551078, 10056.346337488058, 10248.436336001518, 11334.263272887256, 11841.644750657473, 11851.585194518193, 11429.0, 11702.648920532398, 11834.940825295862, 11869.287842729442, 11873.16887817853, 2502.3493891588137, 2523.6971563412326, 2535.9746402536016, 2539.8222124451204, 2540.314115188898, 2082.375287413777, 2369.7274813396507, 2473.938151546208, 2492.0405643827166, 2496.7128780190237, 2136.9849321572283, 2423.672804171432, 2492.7382624824404, 2505.2108585795418, 2511.2842839790665, 2468.1978357033945, 2485.490474452742, 2486.6021436570063, 2490.9252722418355, 2491.825572209946, 2433.914812981537, 2448.779609835123, 2449.2407353720228, 2450.2894160693377, 2458.176510868861, 11784.937635913766, 11799.0, 11866.288022718665, 11980.940095299555, 11991.520339186422, 6550.541462097607, 6783.6269005204695, 6793.898091528631, 6794.524383293171, 6799.762008329734, 4006.9198616027516, 4254.127903779718, 4315.633171180453, 4319.416878721364, 4334.631556317717, 1056.2078441169124, 1234.9444275007647, 1299.4412402666849, 1305.758434689576, 1306.3141850528548, 16639.25123369451, 16737.832621673748, 16763.994160350296, 16816.0, 16854.662906741796, 5862.325832529228, 5955.13650520672, 6136.693165341715, 6184.288806787187, 6235.877542042385, 11526.59656912004, 14164.291785410689, 14173.00788944764, 14175.936804739686, 14202.0, 6893.20728116263, 6898.482613803884, 6902.689378977958, 6903.344182302673, 6909.170899492093, 6034.909476357858, 6192.195014648067, 6235.812925612239, 6263.997760358321, 6275.02737075754, 4392.582704643054, 4548.818047278138, 4557.1797076526545, 4596.724196548218, 4599.448066232007, 1216.8113942338953, 1227.5151315230435, 1317.7298653775954, 1327.9800802987963, 1337.8862796662197, 748.356413484403, 767.5548182054395, 786.944913856036, 800.3277247112453, 801.6753214947955, 5230.424653288135, 6790.932090679129, 6919.6540172991145, 6923.234575183296, 6936.306369363124, 901.9458832470073, 933.0, 943.8961714211431, 946.8637634838084, 947.9052094790603, 4235.597618226264, 4239.321708526621, 4264.786760662017, 4329.76186309756, 4340.435743353407, 14709.264536773118, 15270.541883743283, 15278.541643750705, 15299.158546280061, 15343.386264549294, 14439.061461005002, 14781.63045923839, 15011.924940375227, 15047.774283385757, 15240.847591524165, 10709.518071686793, 10961.0, 10973.28673636227, 10974.835377469344, 11066.889331106586, 6006.489448396936, 6711.127553418024, 7005.754798582026, 7027.15674119109, 7087.255838136922, 13174.341282936006, 13290.136141150795, 13599.52401665937, 13680.179189248278, 13720.725585488035, 13302.0, 13727.588172354845, 13786.793198101836, 13805.861941380457, 13811.654708632364, 9409.952950235478, 9527.0, 9616.02871411345, 9635.470049147083, 9697.272704547046, 10639.042486176282, 10685.732856678645, 10773.0, 10897.073748731447, 10900.56397744113, 7175.533590316612, 9252.028537003518, 9299.488528130747, 9304.209142222986, 9360.017198194091, 9009.234215091528, 9091.954540227256, 9119.817603647758, 9152.679656212, 9249.768755781159, 8226.0540037894, 8366.748997530083, 8367.07962124178, 8368.0, 8391.664333426594, 5859.384764599656, 6021.909671355021, 6038.0, 6147.262328520427, 6222.564420490522, 6096.725647345968, 6119.265688117454, 6253.343398943045, 6260.561760676709, 6408.839779005562], "value": 5474.886098033471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.7623906341346, 399.62634936334547, 402.2578342957245, 413.88825017245324, 414.29156142995475, 5061.974690126549, 5946.0, 6151.263527084143, 6184.78353257635, 6447.548671592978, 5539.224508568794, 6232.84417889553, 6308.842278943029, 6313.032874548955, 6393.552451328397, 3786.753860999026, 4088.0188754698806, 4467.597916187542, 4549.7725113744345, 4601.700889442184, 4186.665066794664, 4593.26507758757, 4601.481511101345, 4618.445786505607, 4619.006913513594, 4581.854536365909, 4588.7935042923145, 4590.885227869313, 4601.171789077965, 4613.215753321943, 3416.8462419191196, 4482.215612267856, 4512.9774351128035, 4571.748553829538, 4609.976950115245, 3494.2662040971427, 3893.240818040483, 3897.707671924617, 3900.395438707005, 3909.1204478992, 4814.301926220678, 6140.293866205398, 6158.060211033555, 6179.598326108833, 6449.29093790146, 5043.924341134849, 5180.456052114511, 5261.842144735664, 5469.507744302992, 5545.0, 5915.822525324247, 6784.72861085556, 6791.864162716718, 6801.319868013208, 6802.591844489297, 3872.2642697887595, 4171.499420069581, 4269.380939763748, 4506.256467682829, 4515.412996310459, 6794.660266986681, 7024.157101147844, 7078.97354883539, 7142.535735177197, 7187.7843664690145, 3961.4748321896277, 4579.084183163381, 4581.541845815392, 4600.125976064537, 4607.44710634726, 3802.5817160112365, 4415.675297410764, 4681.227597446451, 4681.7190968542, 4684.273937539687, 5387.111126664135, 5464.453554644504, 5503.752331145108, 5539.806106786324, 5550.972245138749, 5355.062863998784, 6188.762247550418, 6549.9345006550275, 6822.624755638389, 6846.863062738717, 1294.9935250323688, 1577.7238983177897, 1592.808862936432, 1595.2422599265255, 1599.688255630372, 878.7056336127341, 1024.446798728693, 1041.4844651897208, 1047.9991608014327, 1053.5522402978704, 6450.0, 6455.193100862392, 6466.967665161644, 6469.77355792545, 6479.7408103675325, 6700.631465269359, 7075.92924070763, 7103.538270012433, 7119.724926533852, 7142.178649455275, 5383.650062745909, 5683.318001839723, 6426.518011149183, 6443.420092191725, 6459.806205813833, 3689.9373519978353, 3707.7589956652732, 3709.221063576625, 3718.888433347004, 3724.7206459515646, 5998.880022399615, 6863.588184708834, 7222.858056745333, 7269.600171990592, 7284.963575182091, 5801.345152553864, 5848.0, 7008.894866577006, 7321.78997076683, 7332.78001659951, 7071.292870712888, 7249.746258880914, 7279.59962202084, 7285.5264407812265, 7286.16209135935, 5406.378266499246, 6577.0, 7042.6126563039525, 7142.750003749844, 7169.211386747558, 6685.732570697118, 6862.656867156722, 6906.689198986158, 7024.1571011478945, 7043.612601306772, 5810.360860305278, 7128.465365097535, 7132.787426137465, 7298.708051678086, 7319.865420859775, 4567.606879901529, 4585.358049872953, 4590.701604395704, 4591.288350305708, 4644.2801365788355, 6137.3862613738265, 6715.7911575916805, 7077.079979602619, 7083.291670833081, 7136.892946605909, 6026.578139530367, 6459.6447195402825, 6856.5200435969, 6909.30906909305, 7003.54476958996, 5669.121286200645, 6451.741930322734, 6764.729410823512, 6853.7943861684225, 6880.8967865483055, 6726.6636668167375, 6730.764423245163, 6755.121834161528, 6773.864522709419, 6791.388775010273, 5696.9715151425635, 6100.664463454553, 6175.722092505758, 6878.793636190922, 6954.130733658293, 6119.3268740437625, 6558.868822623616, 6611.933880661324, 6625.304343043911, 6631.933680663132], "value": 4879.6701816469085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.4647479138555, 833.8749187621856, 848.4061157189967, 869.2220462685897, 871.0940621753376, 15916.363345466167, 17155.056471894055, 17156.22796974136, 18189.4543163705, 18850.0, 17734.201960911756, 18153.636927261447, 18213.36253231137, 18365.265389384444, 18453.261869525235, 1015.4212099103514, 1045.4511381524721, 1046.03242001149, 1051.4952822645134, 1052.0741747262398, 1018.1447584029414, 1021.6322124035341, 1027.3579013116803, 1029.382370577655, 1029.9742506437324, 1091.5961094395045, 1093.4478088565263, 1095.2333366643343, 1098.2751384086505, 1101.3557069114538, 1076.2466273608427, 1083.1172594335592, 1088.3687461272443, 1089.2974031749477, 1091.8525998990153, 762.1121393576477, 767.4052609227838, 772.8686123359042, 781.3319611731944, 782.4053719173412, 16753.91623041877, 17081.316747330093, 17168.96986180833, 17202.827971720373, 17212.913935430242, 16417.42539011129, 16762.83237167625, 16965.57586060346, 17024.659506809796, 17079.743803842826, 13565.389557469938, 13671.726565468634, 13801.723965520634, 13931.860681393158, 14005.859941400557, 3468.3410152071024, 3504.5093686883856, 3505.4917037029486, 3505.509228707983, 3510.473428985647, 110773.89226107797, 118055.0, 118367.81632183654, 118936.40531797372, 119425.0, 13724.725505490034, 13902.16587004783, 13954.372053257628, 13978.790318145237, 13986.790198147037, 24373.26880193597, 24819.87590062038, 25056.624150637756, 25364.0, 25409.872950635498, 8879.911200888038, 9171.63313467454, 9203.585838637277, 9204.033576474374, 9239.90760092404, 4447.510773814878, 4811.831585894547, 4890.877728056756, 4906.386701662293, 4968.080905032581, 4297.54875738043, 4333.501647310537, 4352.129574085196, 4370.519242883281, 4376.562343765598, 950.5722424908819, 970.737900766789, 979.6962941488162, 986.8322385194534, 987.4124895687055, 600.7626987339976, 608.3004544773457, 615.4768446820167, 615.7290792051483, 632.2476253258608, 10141.0, 10629.415382154055, 11047.392393418439, 11791.174617776845, 11881.405929703653, 597.979070732531, 600.5015836855399, 608.6986941464004, 613.1232337756961, 619.9225096862892, 5118.948810511847, 5168.586513078944, 5203.297554830126, 5270.314859068373, 5273.235380869829, 92156.6176507353, 101973.0, 104316.47841760743, 105460.41809372866, 105725.0, 79431.20568794354, 83955.58022209849, 85186.0, 85557.28885422257, 85791.57104214563, 79395.0, 79958.6002069986, 80652.38695226063, 81708.59145704114, 83075.7538636921, 11220.326780393203, 11784.0, 11848.822267665819, 11858.703532411413, 12032.398380081137, 30336.69663303427, 39878.2024359517, 40249.79875100723, 40937.795311023256, 41120.79439602783, 53603.0, 68465.31534684589, 68854.65572672104, 69716.65141674259, 70552.0, 14497.492587759378, 14593.92703036478, 14601.0, 14843.554693359216, 14863.405463781328, 13778.65553361174, 16298.022118672918, 16661.0, 17234.741478877575, 17240.137993100547, 15017.474388396353, 15409.614759630651, 15473.84526154769, 15776.526704198892, 15919.522414327126, 15102.848971510144, 15692.0, 15746.527604171893, 15782.974106683028, 15888.364465421717, 14620.926895365455, 15109.47116850905, 15312.540623781304, 15388.230588470755, 15391.61520961985, 9843.2125429964, 10667.650902271378, 10773.946130269298, 11067.778644427228, 11376.601818936297, 11910.0, 12827.871721282667, 12970.0, 12994.610161695164, 13071.803922941353], "value": 8350.325517838819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1731.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 122.0, 123.0, 114.0, 121.0, 184.0, 183.0, 121.0, 122.0, 124.0], "value": 132.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 111.0, 116.0, 173.0, 148.0, 149.0, 118.0, 140.0, 181.0, 143.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 237.0, 283.0, 293.0, 316.0, 243.0, 213.0, 211.0, 215.0, 210.0], "value": 244.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 91.0, 66.0, 91.0, 65.0, 62.0, 74.0, 60.0, 74.0, 51.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 88.0, 64.0, 67.0, 72.0, 86.0, 70.0, 72.0, 98.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 104.0, 105.0, 117.0, 90.0, 142.0, 141.0, 93.0, 94.0], "value": 107.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 102.0, 102.0, 101.0, 101.0, 123.0, 164.0, 102.0, 100.0, 104.0], "value": 110.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 139.0, 162.0, 111.0, 164.0, 160.0, 104.0, 99.0, 162.0, 121.0], "value": 132.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 53.0, 53.0, 57.0, 52.0, 56.0, 54.0, 50.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 71.0, 68.0, 66.0, 49.0, 85.0, 91.0, 89.0, 91.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 90.0, 85.0, 101.0, 88.0, 89.0, 87.0, 87.0, 88.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 176.0, 154.0, 168.0, 163.0, 149.0, 179.0, 173.0, 225.0, 230.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 267.0, 254.0, 210.0, 255.0, 212.0, 217.0, 228.0, 259.0, 240.0], "value": 233.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 100.0, 60.0, 88.0, 102.0, 103.0, 69.0, 74.0, 100.0, 111.0], "value": 87.4, "unit": "score"}]}]} 14:54:45 INFO - Return code: 0 14:54:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:54:45 ERROR - # TBPL SUCCESS # 14:54:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:54:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:54:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:54:45 INFO - 2017-04-07 14:54:45.930 screenresolution[1923:20893] starting screenresolution argv=screenresolution get 14:54:45 INFO - 2017-04-07 14:54:45.933 screenresolution[1923:20893] Display 0: 1600x1200x32@60 14:54:45 INFO - 2017-04-07 14:54:45.940 screenresolution[1924:20896] starting screenresolution argv=screenresolution list 14:54:45 INFO - Available Modes on Display 0 14:54:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:54:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:54:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:54:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:54:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:54:46 INFO - Intel Iris: 14:54:46 INFO - Chipset Model: Intel Iris 14:54:46 INFO - Type: GPU 14:54:46 INFO - Bus: Built-In 14:54:46 INFO - VRAM (Dynamic, Max): 1536 MB 14:54:46 INFO - Vendor: Intel (0x8086) 14:54:46 INFO - Device ID: 0x0a2e 14:54:46 INFO - Revision ID: 0x0009 14:54:46 INFO - Displays: 14:54:46 INFO - Display: 14:54:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:54:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:54:46 INFO - Display Serial Number: 1600x1200 60 14:54:46 INFO - Main Display: Yes 14:54:46 INFO - Mirror: Off 14:54:46 INFO - Online: Yes 14:54:46 INFO - Rotation: Supported 14:54:46 INFO - Return code: 0 14:54:46 INFO - Running post-action listener: _resource_record_post_action 14:54:46 INFO - [mozharness: 2017-04-07 21:54:46.187148Z] Finished run-tests step (success) 14:54:46 INFO - Running post-run listener: _resource_record_post_run 14:54:46 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 712704; Write bytes: 517384704; Read time: 9; Write time: 1634 14:54:46 INFO - TinderboxPrint: CPU usage
54.3% 14:54:46 INFO - TinderboxPrint: I/O read bytes / time
712,704 / 9 14:54:46 INFO - TinderboxPrint: I/O write bytes / time
517,384,704 / 1,634 14:54:46 INFO - TinderboxPrint: CPU idle
2,197.3 (45.7%) 14:54:46 INFO - TinderboxPrint: CPU system
969.8 (20.2%) 14:54:46 INFO - TinderboxPrint: CPU user
1,638.8 (34.1%) 14:54:46 INFO - TinderboxPrint: Swap in / out
208,572,416 / 0 14:54:46 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200247808; Write bytes: 192774144; Read time: 15883; Write time: 413 14:54:46 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 712704; Write bytes: 308816384; Read time: 9; Write time: 1171 14:54:46 INFO - Running post-run listener: _upload_blobber_files 14:54:46 INFO - Blob upload gear active. 14:54:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:54:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:54:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:48 INFO - (blobuploader) - INFO - Done attempting. 14:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:49 INFO - (blobuploader) - INFO - Done attempting. 14:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:50 INFO - (blobuploader) - INFO - Done attempting. 14:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:52 INFO - (blobuploader) - INFO - Done attempting. 14:54:52 INFO - (blobuploader) - INFO - Iteration through files over. 14:54:52 INFO - Return code: 0 14:54:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:54:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:54:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1779e7fcb48f16f6712b602e8cc4cf819a308343609962a63ab3d5146e5f6e80cc06a218a407544175fb2aeab031890999042e55f85f185c16efb79367b33654", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36cd2993fa96d8f1e6ae2f9534f0093254946d9f9ec61ca18118656742e77e2c794008a47fc7f685e6f1c08925dcfafbb8523233b7e8997276da20b1dc604d9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4c99ad13d235e5d1de24170a081f146cf7454fbad06419881baa6d2285d2a852c908f386bab7e37fe34c814bf401e2fd504277efb561be0f090bab7a5b6f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2096d1d55c45cc0933ffd26ebef1a5ce52da17218cf7be24e2ce7c1f8a20d83110429c6a389fe8bf278251876dc7d8221cc942c3b1f12744bbbe492d94ea86"} 14:54:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:54:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:54:52 INFO - Contents: 14:54:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1779e7fcb48f16f6712b602e8cc4cf819a308343609962a63ab3d5146e5f6e80cc06a218a407544175fb2aeab031890999042e55f85f185c16efb79367b33654", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36cd2993fa96d8f1e6ae2f9534f0093254946d9f9ec61ca18118656742e77e2c794008a47fc7f685e6f1c08925dcfafbb8523233b7e8997276da20b1dc604d9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4c99ad13d235e5d1de24170a081f146cf7454fbad06419881baa6d2285d2a852c908f386bab7e37fe34c814bf401e2fd504277efb561be0f090bab7a5b6f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2096d1d55c45cc0933ffd26ebef1a5ce52da17218cf7be24e2ce7c1f8a20d83110429c6a389fe8bf278251876dc7d8221cc942c3b1f12744bbbe492d94ea86"} 14:54:52 INFO - Running post-run listener: copy_logs_to_upload_dir 14:54:52 INFO - Copying logs to upload dir... 14:54:52 INFO - mkdir: /builds/slave/test/build/upload/logs 14:54:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.720172 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-07 14:54:52.651516) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:52.655284) ========= 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.03RaeYJpTW/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.hq01Qx8StG/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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/1779e7fcb48f16f6712b602e8cc4cf819a308343609962a63ab3d5146e5f6e80cc06a218a407544175fb2aeab031890999042e55f85f185c16efb79367b33654", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36cd2993fa96d8f1e6ae2f9534f0093254946d9f9ec61ca18118656742e77e2c794008a47fc7f685e6f1c08925dcfafbb8523233b7e8997276da20b1dc604d9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4c99ad13d235e5d1de24170a081f146cf7454fbad06419881baa6d2285d2a852c908f386bab7e37fe34c814bf401e2fd504277efb561be0f090bab7a5b6f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2096d1d55c45cc0933ffd26ebef1a5ce52da17218cf7be24e2ce7c1f8a20d83110429c6a389fe8bf278251876dc7d8221cc942c3b1f12744bbbe492d94ea86"} build_url:https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/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/1779e7fcb48f16f6712b602e8cc4cf819a308343609962a63ab3d5146e5f6e80cc06a218a407544175fb2aeab031890999042e55f85f185c16efb79367b33654", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36cd2993fa96d8f1e6ae2f9534f0093254946d9f9ec61ca18118656742e77e2c794008a47fc7f685e6f1c08925dcfafbb8523233b7e8997276da20b1dc604d9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4c99ad13d235e5d1de24170a081f146cf7454fbad06419881baa6d2285d2a852c908f386bab7e37fe34c814bf401e2fd504277efb561be0f090bab7a5b6f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2096d1d55c45cc0933ffd26ebef1a5ce52da17218cf7be24e2ce7c1f8a20d83110429c6a389fe8bf278251876dc7d8221cc942c3b1f12744bbbe492d94ea86"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:52.689918) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:52.690370) ========= 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.03RaeYJpTW/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.hq01Qx8StG/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.005476 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:52.738878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 14:54:52.739242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 14:54:52.739625) ========= ========= Total master_lag: 0.19 =========