builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0291 starttime: 1485864971.21 results: success (0) buildid: 20170131030205 builduid: 98f0121b729d47b1bfa7e25b44eb052a revision: 9c06e744b1befb3a2e2fdac7414ce18220774a1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.209837) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.210291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.210569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.238345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.238675) ========= 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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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-01-31 04:16:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.4M=0.001s 2017-01-31 04:16:11 (20.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115169 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.377719) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.378023) ========= 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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.024862 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:11.425852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 04:16:11.426180) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9c06e744b1befb3a2e2fdac7414ce18220774a1d --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 9c06e744b1befb3a2e2fdac7414ce18220774a1d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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-01-31 04:16:11,536 truncating revision to first 12 chars 2017-01-31 04:16:11,536 Setting DEBUG logging. 2017-01-31 04:16:11,536 attempt 1/10 2017-01-31 04:16:11,536 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9c06e744b1be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 04:16:12,980 unpacking tar archive at: mozilla-central-9c06e744b1be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.717678 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 04:16:13.173288) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:13.173638) ========= script_repo_revision: 9c06e744b1befb3a2e2fdac7414ce18220774a1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:13.174031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:13.174309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 04:16:13.196486) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-31 04:16:13.196891) ========= /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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:13 INFO - MultiFileLogger online at 20170131 04:16:13 in /builds/slave/test 04:16:13 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 04:16:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:13 INFO - {'append_to_log': False, 04:16:13 INFO - 'base_work_dir': '/builds/slave/test', 04:16:13 INFO - 'blob_upload_branch': 'Firefox', 04:16:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:13 INFO - 'branch': 'Firefox', 04:16:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:13 INFO - 'config_files': ('talos/mac_config.py',), 04:16:13 INFO - 'default_actions': ('clobber', 04:16:13 INFO - 'read-buildbot-config', 04:16:13 INFO - 'download-and-extract', 04:16:13 INFO - 'populate-webroot', 04:16:13 INFO - 'create-virtualenv', 04:16:13 INFO - 'install', 04:16:13 INFO - 'run-tests'), 04:16:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:13 INFO - 'download_minidump_stackwalk': True, 04:16:13 INFO - 'download_symbols': 'ondemand', 04:16:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:13 INFO - 'installer_path': 'installer.exe', 04:16:13 INFO - 'log_level': 'info', 04:16:13 INFO - 'log_name': 'talos', 04:16:13 INFO - 'log_to_console': True, 04:16:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:16:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:16:13 INFO - 'opt_config_files': (), 04:16:13 INFO - 'pip_index': False, 04:16:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:16:13 INFO - 'cmd': ('bash', 04:16:13 INFO - '-c', 04:16:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:16:13 INFO - 'enabled': True, 04:16:13 INFO - 'halt_on_failure': False, 04:16:13 INFO - 'name': 'check_screen_resolution'},), 04:16:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:16:13 INFO - 'cmd': ('bash', 04:16:13 INFO - '-c', 04:16:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:16:13 INFO - 'enabled': True, 04:16:13 INFO - 'halt_on_failure': False, 04:16:13 INFO - 'name': 'check_screen_resolution'},), 04:16:13 INFO - 'run_cmd_checks_enabled': True, 04:16:13 INFO - 'sps_profile': False, 04:16:13 INFO - 'sps_profile_interval': 0, 04:16:13 INFO - 'suite': 'dromaeojs-e10s', 04:16:13 INFO - 'system_bits': '32', 04:16:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:13 INFO - 'title': 't-yosemite-r7-0291', 04:16:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:13 INFO - 'use_talos_json': True, 04:16:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:13 INFO - 'work_dir': 'build'} 04:16:13 INFO - [mozharness: 2017-01-31 12:16:13.413263Z] Running clobber step. 04:16:13 INFO - Running pre-action listener: _resource_record_pre_action 04:16:13 INFO - Running main action method: clobber 04:16:13 INFO - rmtree: /builds/slave/test/build 04:16:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:15 INFO - Running post-action listener: _resource_record_post_action 04:16:15 INFO - [mozharness: 2017-01-31 12:16:15.845413Z] Finished clobber step (success) 04:16:15 INFO - [mozharness: 2017-01-31 12:16:15.845525Z] Running read-buildbot-config step. 04:16:15 INFO - Running pre-action listener: _resource_record_pre_action 04:16:15 INFO - Running main action method: read_buildbot_config 04:16:15 INFO - Using buildbot properties: 04:16:15 INFO - { 04:16:15 INFO - "project": "", 04:16:15 INFO - "product": "firefox", 04:16:15 INFO - "script_repo_revision": "production", 04:16:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:16:15 INFO - "repository": "", 04:16:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:16:15 INFO - "buildid": "20170131030205", 04:16:15 INFO - "stage_platform": "macosx64", 04:16:15 INFO - "basedir": "/builds/slave/test", 04:16:15 INFO - "nightly_build": "True", 04:16:15 INFO - "buildnumber": 33, 04:16:15 INFO - "slavename": "t-yosemite-r7-0291", 04:16:15 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:16:15 INFO - "platform": "yosemite_r7", 04:16:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:16:15 INFO - "branch": "mozilla-central", 04:16:15 INFO - "repo_path": "mozilla-central", 04:16:15 INFO - "revision": "9c06e744b1befb3a2e2fdac7414ce18220774a1d", 04:16:15 INFO - "pgo_build": "False", 04:16:15 INFO - "builduid": "98f0121b729d47b1bfa7e25b44eb052a", 04:16:15 INFO - "slavebuilddir": "test" 04:16:15 INFO - } 04:16:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:16:15 INFO - Running post-action listener: _resource_record_post_action 04:16:15 INFO - [mozharness: 2017-01-31 12:16:15.848954Z] Finished read-buildbot-config step (success) 04:16:15 INFO - [mozharness: 2017-01-31 12:16:15.849084Z] Running download-and-extract step. 04:16:15 INFO - Running pre-action listener: _resource_record_pre_action 04:16:15 INFO - Running main action method: download_and_extract 04:16:15 INFO - mkdir: /builds/slave/test/build/tests 04:16: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')]} 04:16:15 INFO - trying https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:16:15 INFO - Downloading https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:16:17 INFO - Downloaded 1199 bytes. 04:16:17 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:16:17 INFO - Using the following test package requirements: 04:16:17 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:16:17 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:16:17 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:16:17 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'jsshell-mac.zip'], 04:16:17 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:16:17 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:16:17 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:16:17 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:16:17 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:16:17 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:17 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:16:17 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:16:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:16:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:16:17 INFO - Fetch https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:16:18 INFO - Expected file size: 16368105 04:16:18 INFO - Obtained file size: 16368105 04:16:24 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:16:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:16:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:16:24 INFO - Fetch https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:16:25 INFO - Expected file size: 16368105 04:16:25 INFO - Obtained file size: 16368105 04:16:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:16:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:16:31 INFO - Fetch https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:16:32 INFO - Expected file size: 14403454 04:16:32 INFO - Obtained file size: 14403454 04:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:32 INFO - trying https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:16:32 INFO - Downloading https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:16:34 INFO - Downloaded 70260609 bytes. 04:16:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:16:34 INFO - mkdir: /builds/slave/test/properties 04:16:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:34 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:34 INFO - Contents: 04:16:34 INFO - build_url:https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:16:35 INFO - Running post-action listener: _resource_record_post_action 04:16:35 INFO - Running post-action listener: set_extra_try_arguments 04:16:35 INFO - [mozharness: 2017-01-31 12:16:35.618415Z] Finished download-and-extract step (success) 04:16:35 INFO - [mozharness: 2017-01-31 12:16:35.618564Z] Running populate-webroot step. 04:16:35 INFO - Running pre-action listener: _resource_record_pre_action 04:16:35 INFO - Running main action method: populate_webroot 04:16:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:35 INFO - '--tppagecycles', 04:16:35 INFO - '7'], 04:16:35 INFO - 'tests': ['tsvgm']}}, 04:16:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:16:35 INFO - 'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:16:35 INFO - 'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['damp', 'tps']}, 04:16:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:16:35 INFO - 'tests': ['damp', 'tps']}, 04:16:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['dromaeo_dom']}, 04:16:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['basic_compositor_video']}, 04:16:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:16:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['a11yr', 04:16:35 INFO - 'ts_paint', 04:16:35 INFO - 'tpaint', 04:16:35 INFO - 'sessionrestore', 04:16:35 INFO - 'sessionrestore_no_auto_restore', 04:16:35 INFO - 'tabpaint']}, 04:16:35 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:35 INFO - 'ts_paint', 04:16:35 INFO - 'tpaint', 04:16:35 INFO - 'sessionrestore', 04:16:35 INFO - 'sessionrestore_no_auto_restore', 04:16:35 INFO - 'tabpaint']}, 04:16:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:35 INFO - 'ts_paint', 04:16:35 INFO - 'tpaint', 04:16:35 INFO - 'sessionrestore', 04:16:35 INFO - 'sessionrestore_no_auto_restore', 04:16:35 INFO - 'tabpaint']}, 04:16:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:35 INFO - 'ts_paint', 04:16:35 INFO - 'tpaint', 04:16:35 INFO - 'sessionrestore', 04:16:35 INFO - 'sessionrestore_no_auto_restore', 04:16:35 INFO - 'tabpaint']}, 04:16:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['a11yr', 04:16:35 INFO - 'ts_paint', 04:16:35 INFO - 'tpaint', 04:16:35 INFO - 'sessionrestore', 04:16:35 INFO - 'sessionrestore_no_auto_restore', 04:16:35 INFO - 'tabpaint']}, 04:16:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['a11yr', 04:16:35 INFO - 'ts_paint', 04:16:35 INFO - 'tpaint', 04:16:35 INFO - 'sessionrestore', 04:16:35 INFO - 'sessionrestore_no_auto_restore', 04:16:35 INFO - 'tabpaint']}, 04:16:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['tsvgx', 04:16:35 INFO - 'tsvgr_opacity', 04:16:35 INFO - 'tart', 04:16:35 INFO - 'tscrollx', 04:16:35 INFO - 'cart', 04:16:35 INFO - 'tsvg_static']}, 04:16:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:35 INFO - 'tsvgr_opacity', 04:16:35 INFO - 'tart', 04:16:35 INFO - 'tscrollx', 04:16:35 INFO - 'cart', 04:16:35 INFO - 'tsvg_static']}, 04:16:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:16:35 INFO - 'talos_options': ['--disable-e10s'], 04:16:35 INFO - 'tests': ['tp5o']}, 04:16:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:16:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:16:35 INFO - 'talos_options': ['--disable-e10s', 04:16:35 INFO - '--xperf_path', 04:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:35 INFO - 'tests': ['tp5n']}, 04:16:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:16:35 INFO - 'talos_options': ['--xperf_path', 04:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:35 INFO - 'tests': ['tp5n']}}, 04:16:35 INFO - 'talos.zip': {'path': '', 04:16:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:35 INFO - Running post-action listener: _resource_record_post_action 04:16:35 INFO - [mozharness: 2017-01-31 12:16:35.637111Z] Finished populate-webroot step (success) 04:16:35 INFO - [mozharness: 2017-01-31 12:16:35.637217Z] Running create-virtualenv step. 04:16:35 INFO - Running pre-action listener: _resource_record_pre_action 04:16:35 INFO - Running main action method: create_virtualenv 04:16:35 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:35 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 04:16:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:35 INFO - Using real prefix '/tools/python27' 04:16:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:39 INFO - Installing pip.................done. 04:16:39 INFO - Return code: 0 04:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:16:39 INFO - Reading from file tmpfile_stdout 04:16:39 INFO - Output received: 04:16:39 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) 04:16:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:39 INFO - 'HOME': '/Users/cltbld', 04:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:39 INFO - 'LOGNAME': 'cltbld', 04:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:39 INFO - 'MOZ_NO_REMOTE': '1', 04:16:39 INFO - 'NO_EM_RESTART': '1', 04:16:39 INFO - 'PAGER': '/bin/cat', 04:16:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:39 INFO - 'PWD': '/builds/slave/test', 04:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:39 INFO - 'SHELL': '/bin/bash', 04:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:16:39 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:39 INFO - 'USER': 'cltbld', 04:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:39 INFO - 'XPC_FLAGS': '0x0', 04:16:39 INFO - 'XPC_SERVICE_NAME': '0', 04:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:39 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 04:16:39 INFO - Cleaning up... 04:16:39 INFO - Return code: 0 04:16:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:39 INFO - 'HOME': '/Users/cltbld', 04:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:39 INFO - 'LOGNAME': 'cltbld', 04:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:39 INFO - 'MOZ_NO_REMOTE': '1', 04:16:39 INFO - 'NO_EM_RESTART': '1', 04:16:39 INFO - 'PAGER': '/bin/cat', 04:16:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:39 INFO - 'PWD': '/builds/slave/test', 04:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:39 INFO - 'SHELL': '/bin/bash', 04:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:16:39 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:39 INFO - 'USER': 'cltbld', 04:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:39 INFO - 'XPC_FLAGS': '0x0', 04:16:39 INFO - 'XPC_SERVICE_NAME': '0', 04:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:40 INFO - Downloading/unpacking psutil>=3.1.1 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:43 INFO - Installing collected packages: psutil 04:16:43 INFO - Running setup.py install for psutil 04:16:43 INFO - building 'psutil._psutil_osx' extension 04:16:43 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 04:16:44 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 04:16:44 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 04:16:44 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 04:16:44 INFO - building 'psutil._psutil_posix' extension 04:16:44 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 04:16:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:16:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:16:44 INFO - ^ 04:16:44 INFO - 1 warning generated. 04:16:44 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 04:16:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:44 INFO - Successfully installed psutil 04:16:44 INFO - Cleaning up... 04:16:44 INFO - Return code: 0 04:16:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:44 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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:44 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 04:16:44 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 04:16:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:16:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:44 INFO - 'HOME': '/Users/cltbld', 04:16:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:44 INFO - 'LOGNAME': 'cltbld', 04:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:44 INFO - 'MOZ_NO_REMOTE': '1', 04:16:44 INFO - 'NO_EM_RESTART': '1', 04:16:44 INFO - 'PAGER': '/bin/cat', 04:16:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:44 INFO - 'PWD': '/builds/slave/test', 04:16:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:44 INFO - 'SHELL': '/bin/bash', 04:16:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:16:44 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:16:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:44 INFO - 'USER': 'cltbld', 04:16:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:44 INFO - 'XPC_FLAGS': '0x0', 04:16:44 INFO - 'XPC_SERVICE_NAME': '0', 04:16:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:16:45 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 04:16:45 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 04:16:45 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 04:16:45 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 04:16:45 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 04:16:45 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 04:16:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:16:47 INFO - Installing collected packages: mozsystemmonitor 04:16:47 INFO - Running setup.py install for mozsystemmonitor 04:16:48 INFO - Successfully installed mozsystemmonitor 04:16:48 INFO - Cleaning up... 04:16:48 INFO - Return code: 0 04:16:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:48 INFO - 'HOME': '/Users/cltbld', 04:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:48 INFO - 'LOGNAME': 'cltbld', 04:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:48 INFO - 'MOZ_NO_REMOTE': '1', 04:16:48 INFO - 'NO_EM_RESTART': '1', 04:16:48 INFO - 'PAGER': '/bin/cat', 04:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:48 INFO - 'PWD': '/builds/slave/test', 04:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:48 INFO - 'SHELL': '/bin/bash', 04:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:16:48 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:48 INFO - 'USER': 'cltbld', 04:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:48 INFO - 'XPC_FLAGS': '0x0', 04:16:48 INFO - 'XPC_SERVICE_NAME': '0', 04:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:48 INFO - Downloading/unpacking jsonschema==2.5.1 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:51 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:51 INFO - warning: no files found matching '*.txt' 04:16:51 INFO - no previously-included directories found matching 'build' 04:16:51 INFO - no previously-included directories found matching 'dist' 04:16:51 INFO - no previously-included directories found matching '.git*' 04:16:51 INFO - Installing collected packages: jsonschema, functools32 04:16:51 INFO - Running setup.py install for functools32 04:16:51 INFO - warning: no files found matching '*.txt' 04:16:51 INFO - no previously-included directories found matching 'build' 04:16:51 INFO - no previously-included directories found matching 'dist' 04:16:51 INFO - no previously-included directories found matching '.git*' 04:16:51 INFO - Successfully installed jsonschema functools32 04:16:51 INFO - Cleaning up... 04:16:51 INFO - Return code: 0 04:16:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:16:51 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')]} 04:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:51 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')]} 04:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:51 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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:51 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 04:16:51 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 04:16:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:16:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:51 INFO - 'HOME': '/Users/cltbld', 04:16:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:51 INFO - 'LOGNAME': 'cltbld', 04:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:51 INFO - 'MOZ_NO_REMOTE': '1', 04:16:51 INFO - 'NO_EM_RESTART': '1', 04:16:51 INFO - 'PAGER': '/bin/cat', 04:16:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:51 INFO - 'PWD': '/builds/slave/test', 04:16:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:51 INFO - 'SHELL': '/bin/bash', 04:16:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:16:51 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:16:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:51 INFO - 'USER': 'cltbld', 04:16:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:51 INFO - 'XPC_FLAGS': '0x0', 04:16:51 INFO - 'XPC_SERVICE_NAME': '0', 04:16:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:16:52 INFO - Cleaning up... 04:16:52 INFO - Return code: 0 04:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:52 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')]} 04:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:52 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')]} 04:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:52 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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:52 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 04:16:52 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 04:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:52 INFO - 'HOME': '/Users/cltbld', 04:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:52 INFO - 'LOGNAME': 'cltbld', 04:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:52 INFO - 'MOZ_NO_REMOTE': '1', 04:16:52 INFO - 'NO_EM_RESTART': '1', 04:16:52 INFO - 'PAGER': '/bin/cat', 04:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:52 INFO - 'PWD': '/builds/slave/test', 04:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:52 INFO - 'SHELL': '/bin/bash', 04:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:16:52 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:52 INFO - 'USER': 'cltbld', 04:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:52 INFO - 'XPC_FLAGS': '0x0', 04:16:52 INFO - 'XPC_SERVICE_NAME': '0', 04:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:52 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 04:16:52 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 04:16:52 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 04:16:52 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 04:16:52 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 04:16:52 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 04:16:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:55 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 04:16:55 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 04:16:55 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 04:16:55 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 04:16:55 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 04:16:55 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 04:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:55 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 04:16:55 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 04:16:55 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 04:16:55 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 04:16:55 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 04:16:55 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 04:16:56 INFO - Downloading docopt-0.6.1.tar.gz 04:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:56 INFO - Running setup.py install for blobuploader 04:16:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:56 INFO - Running setup.py install for requests 04:16:56 INFO - Running setup.py install for docopt 04:16:57 INFO - Successfully installed blobuploader requests docopt 04:16:57 INFO - Cleaning up... 04:16:57 INFO - Return code: 0 04:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:16:57 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 04:16:57 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 04:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:57 INFO - 'HOME': '/Users/cltbld', 04:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:57 INFO - 'LOGNAME': 'cltbld', 04:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:57 INFO - 'MOZ_NO_REMOTE': '1', 04:16:57 INFO - 'NO_EM_RESTART': '1', 04:16:57 INFO - 'PAGER': '/bin/cat', 04:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:57 INFO - 'PWD': '/builds/slave/test', 04:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:57 INFO - 'SHELL': '/bin/bash', 04:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:16:57 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:57 INFO - 'USER': 'cltbld', 04:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:57 INFO - 'XPC_FLAGS': '0x0', 04:16:57 INFO - 'XPC_SERVICE_NAME': '0', 04:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-py1AwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ov3LvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-l9IxMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-T1zXzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-wkFKU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-W18Lgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Yfwu1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-5KtyLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-y35uNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-M07jWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-a095Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Ir8mkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-NdzZnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-dIS9qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-FnnK5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-uJO3HK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-uoxPM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:59 INFO - Running setup.py install for manifestparser 04:16:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Running setup.py install for mozcrash 04:16:59 INFO - Running setup.py install for mozdebug 04:16:59 INFO - Running setup.py install for mozdevice 04:16:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Running setup.py install for mozfile 04:16:59 INFO - Running setup.py install for mozhttpd 04:17:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for mozinfo 04:17:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for mozInstall 04:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for mozleak 04:17:00 INFO - Running setup.py install for mozlog 04:17:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for moznetwork 04:17:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for mozprocess 04:17:01 INFO - Running setup.py install for mozprofile 04:17:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:01 INFO - Running setup.py install for mozrunner 04:17:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:01 INFO - Running setup.py install for mozscreenshot 04:17:01 INFO - Running setup.py install for moztest 04:17:01 INFO - Running setup.py install for mozversion 04:17:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:01 INFO - Cleaning up... 04:17:01 INFO - Return code: 0 04:17:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:01 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')]} 04:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:01 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')]} 04:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:01 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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:17:01 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 04:17:01 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 04:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:01 INFO - 'HOME': '/Users/cltbld', 04:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:01 INFO - 'LOGNAME': 'cltbld', 04:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:01 INFO - 'MOZ_NO_REMOTE': '1', 04:17:01 INFO - 'NO_EM_RESTART': '1', 04:17:01 INFO - 'PAGER': '/bin/cat', 04:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:01 INFO - 'PWD': '/builds/slave/test', 04:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:01 INFO - 'SHELL': '/bin/bash', 04:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:17:01 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:01 INFO - 'USER': 'cltbld', 04:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:01 INFO - 'XPC_FLAGS': '0x0', 04:17:01 INFO - 'XPC_SERVICE_NAME': '0', 04:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-TbUHbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:02 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)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-gYWFkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:02 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)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-MlpGpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:02 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)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-orWXdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Ej3m4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:02 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)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-cYcVpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:02 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)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-9WY7Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:02 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)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-pcL1GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:02 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)) 04:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-u5trY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:03 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)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-VEfpJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:03 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)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-NV9Rze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:03 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)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-c4rlIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-v3yC4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:03 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)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-LTvfOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:03 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)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-d5bvcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:03 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)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-jHuxwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:03 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)) 04:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-RIboWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:03 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)) 04:17:03 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)) 04:17:03 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)) 04:17:03 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)) 04:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:03 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 04:17:03 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 04:17:03 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 04:17:03 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 04:17:03 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 04:17:03 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 04:17:06 INFO - Downloading blessings-1.6.tar.gz 04:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:06 INFO - Installing collected packages: blessings 04:17:06 INFO - Running setup.py install for blessings 04:17:06 INFO - Successfully installed blessings 04:17:06 INFO - Cleaning up... 04:17:06 INFO - Return code: 0 04:17:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:07 INFO - Reading from file tmpfile_stdout 04:17:07 INFO - Current package versions: 04:17:07 INFO - blessings == 1.6 04:17:07 INFO - blobuploader == 1.2.4 04:17:07 INFO - docopt == 0.6.1 04:17:07 INFO - functools32 == 3.2.3-2 04:17:07 INFO - jsonschema == 2.5.1 04:17:07 INFO - manifestparser == 1.1 04:17:07 INFO - mozInstall == 1.12 04:17:07 INFO - mozcrash == 1.0 04:17:07 INFO - mozdebug == 0.1 04:17:07 INFO - mozdevice == 0.49 04:17:07 INFO - mozfile == 1.2 04:17:07 INFO - mozhttpd == 0.7 04:17:07 INFO - mozinfo == 0.9 04:17:07 INFO - mozleak == 0.1 04:17:07 INFO - mozlog == 3.4 04:17:07 INFO - moznetwork == 0.27 04:17:07 INFO - mozprocess == 0.24 04:17:07 INFO - mozprofile == 0.28 04:17:07 INFO - mozrunner == 6.13 04:17:07 INFO - mozscreenshot == 0.1 04:17:07 INFO - mozsystemmonitor == 0.3 04:17:07 INFO - moztest == 0.8 04:17:07 INFO - mozversion == 1.4 04:17:07 INFO - psutil == 3.1.1 04:17:07 INFO - requests == 1.2.3 04:17:07 INFO - wsgiref == 0.1.2 04:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:07 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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:17:07 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 04:17:07 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 04:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:07 INFO - 'HOME': '/Users/cltbld', 04:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:07 INFO - 'LOGNAME': 'cltbld', 04:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:07 INFO - 'MOZ_NO_REMOTE': '1', 04:17:07 INFO - 'NO_EM_RESTART': '1', 04:17:07 INFO - 'PAGER': '/bin/cat', 04:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:07 INFO - 'PWD': '/builds/slave/test', 04:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:07 INFO - 'SHELL': '/bin/bash', 04:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:17:07 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:07 INFO - 'USER': 'cltbld', 04:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:07 INFO - 'XPC_FLAGS': '0x0', 04:17:07 INFO - 'XPC_SERVICE_NAME': '0', 04:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 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)) 04:17:08 INFO - Cleaning up... 04:17:08 INFO - Return code: 0 04:17:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:08 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 0x104541b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104544768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96535aed30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, '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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 04:17:08 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 04:17:08 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 04:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:08 INFO - 'HOME': '/Users/cltbld', 04:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:08 INFO - 'LOGNAME': 'cltbld', 04:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:08 INFO - 'MOZ_NO_REMOTE': '1', 04:17:08 INFO - 'NO_EM_RESTART': '1', 04:17:08 INFO - 'PAGER': '/bin/cat', 04:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:08 INFO - 'PWD': '/builds/slave/test', 04:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:08 INFO - 'SHELL': '/bin/bash', 04:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:17:08 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:08 INFO - 'USER': 'cltbld', 04:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:08 INFO - 'XPC_FLAGS': '0x0', 04:17:08 INFO - 'XPC_SERVICE_NAME': '0', 04:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:17:08 INFO - Cleaning up... 04:17:08 INFO - Return code: 0 04:17:08 INFO - Running post-action listener: _resource_record_post_action 04:17:08 INFO - Running post-action listener: _start_resource_monitoring 04:17:08 INFO - Starting resource monitoring. 04:17:08 INFO - [mozharness: 2017-01-31 12:17:08.739228Z] Finished create-virtualenv step (success) 04:17:08 INFO - [mozharness: 2017-01-31 12:17:08.740156Z] Running install step. 04:17:08 INFO - Running pre-action listener: _resource_record_pre_action 04:17:08 INFO - Running main action method: install 04:17:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:08 INFO - Reading from file tmpfile_stdout 04:17:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:09 INFO - Reading from file tmpfile_stdout 04:17:09 INFO - Output received: 04:17:09 INFO - Usage: mozinstall [options] installer 04:17:09 INFO - Options: 04:17:09 INFO - -h, --help show this help message and exit 04:17:09 INFO - -d DEST, --destination=DEST 04:17:09 INFO - Directory to install application into. [default: 04:17:09 INFO - "/builds/slave/test"] 04:17:09 INFO - --app=APP Application being installed. [default: firefox] 04:17:09 INFO - mkdir: /builds/slave/test/build/application 04:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:17:30 INFO - Reading from file tmpfile_stdout 04:17:30 INFO - Output received: 04:17:30 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:17:30 INFO - Running post-action listener: _resource_record_post_action 04:17:30 INFO - [mozharness: 2017-01-31 12:17:30.899378Z] Finished install step (success) 04:17:30 INFO - [mozharness: 2017-01-31 12:17:30.899527Z] Running run-tests step. 04:17:30 INFO - Running pre-action listener: _resource_record_pre_action 04:17:30 INFO - Running main action method: run_tests 04:17:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:17:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:17:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:17:30 INFO - 2017-01-31 04:17:30.914 screenresolution[1630:7334] starting screenresolution argv=screenresolution get 04:17:30 INFO - 2017-01-31 04:17:30.916 screenresolution[1630:7334] Display 0: 1600x1200x32@60 04:17:30 INFO - 2017-01-31 04:17:30.922 screenresolution[1631:7336] starting screenresolution argv=screenresolution list 04:17:30 INFO - Available Modes on Display 0 04:17:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:17:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:17:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:17:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:17:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:17:31 INFO - Intel Iris: 04:17:31 INFO - Chipset Model: Intel Iris 04:17:31 INFO - Type: GPU 04:17:31 INFO - Bus: Built-In 04:17:31 INFO - VRAM (Dynamic, Max): 1536 MB 04:17:31 INFO - Vendor: Intel (0x8086) 04:17:31 INFO - Device ID: 0x0a2e 04:17:31 INFO - Revision ID: 0x0009 04:17:31 INFO - Displays: 04:17:31 INFO - Display: 04:17:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:17:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:17:31 INFO - Display Serial Number: 1600x1200 60 04:17:31 INFO - Main Display: Yes 04:17:31 INFO - Mirror: Off 04:17:31 INFO - Online: Yes 04:17:31 INFO - Rotation: Supported 04:17:31 INFO - Return code: 0 04:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:31 INFO - Python 2.7.3 04:17:31 INFO - Return code: 0 04:17:31 INFO - grabbing minidump binary from tooltool 04:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:31 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 0x10431fd30>, '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 0x104246db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104314be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:31 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 04:17:31 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 04:17:31 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 04:17:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:31 INFO - Return code: 0 04:17:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:17:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:17:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:31 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 04:17:31 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0291 --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 04:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gCWLbKOkS/Render', 04:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:31 INFO - 'HOME': '/Users/cltbld', 04:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:31 INFO - 'LOGNAME': 'cltbld', 04:17:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:31 INFO - 'MOZ_NO_REMOTE': '1', 04:17:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:31 INFO - 'NO_EM_RESTART': '1', 04:17:31 INFO - 'PAGER': '/bin/cat', 04:17:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:31 INFO - 'PWD': '/builds/slave/test', 04:17:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:31 INFO - 'SHELL': '/bin/bash', 04:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GnWmfGiCwZ/Listeners', 04:17:31 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 04:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:31 INFO - 'USER': 'cltbld', 04:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:31 INFO - 'XPC_FLAGS': '0x0', 04:17:31 INFO - 'XPC_SERVICE_NAME': '0', 04:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:31 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 04:17:31 INFO - mozversion application_buildid: 20170131030205 04:17:31 INFO - mozversion application_changeset: 9c06e744b1befb3a2e2fdac7414ce18220774a1d 04:17:31 INFO - mozversion application_display_name: Nightly 04:17:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:31 INFO - mozversion application_name: Firefox 04:17:31 INFO - mozversion application_remotingname: firefox 04:17:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:17:31 INFO - mozversion application_vendor: Mozilla 04:17:31 INFO - mozversion application_version: 54.0a1 04:17:31 INFO - mozversion platform_buildid: 20170131030205 04:17:31 INFO - mozversion platform_changeset: 9c06e744b1befb3a2e2fdac7414ce18220774a1d 04:17:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:17:31 INFO - mozversion platform_version: 54.0a1 04:17:31 INFO - using testdate: 1485865051 04:17:31 INFO - actual date: 1485865051 04:17:31 INFO - starting webserver on 'localhost:49250' 04:17:31 INFO - SUITE-START | Running 2 tests 04:17:31 INFO - TEST-START | dromaeo_css 04:17:31 INFO - operating with platform_type : mac_ 04:17:31 INFO - Initialising browser for dromaeo_css test... 04:17:31 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpFtJ3pQ/profile http://localhost:49250/getInfo.html) 04:17:34 INFO - PROCESS | 1641 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:17:34 INFO - PROCESS | 1641 | 2017-01-31 04:17:34.655 plugin-container[1644:7513] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 04:17:34 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:34 INFO - PROCESS | 1641 | 2017-01-31 04:17:34.656 plugin-container[1644:7513] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x941b, name = 'com.apple.CFPasteboardClient' 04:17:34 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:34 INFO - PROCESS | 1641 | 2017-01-31 04:17:34.656 plugin-container[1644:7513] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:17:34 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 04:17:34 INFO - PROCESS | 1641 | colorDepth:24 04:17:34 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 04:17:34 INFO - PROCESS | 1641 | __metrics 04:17:34 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3284: TypeError: this.tabs is undefined 04:17:34 INFO - PROCESS | 1641 | 1485865054797 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpFtJ3pQ/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpFtJ3pQ/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpFtJ3pQ/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpFtJ3pQ/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:17:35 INFO - TEST-INFO | 1641: exit 0 04:17:35 INFO - Browser initialized. 04:17:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:35 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpFtJ3pQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:37 INFO - PROCESS | 1645 | 2017-01-31 04:17:37.997 plugin-container[1646:7631] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464b, name = 'com.apple.tsm.portname' 04:17:38 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:38 INFO - PROCESS | 1645 | 2017-01-31 04:17:37.998 plugin-container[1646:7631] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 04:17:38 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:38 INFO - PROCESS | 1645 | 2017-01-31 04:17:37.998 plugin-container[1646:7631] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:17:47 INFO - PROCESS | 1645 | RSS: Main: 234184704 04:17:47 INFO - PROCESS | 1645 | 04:20:50 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 04:20:51 INFO - PROCESS | 1645 | RSS: Main: 259743744 04:20:51 INFO - PROCESS | 1645 | 04:22:35 INFO - PROCESS | 1645 | ************************* 04:22:35 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 04:22:35 INFO - PROCESS | 1645 | 04:22:35 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:22:35 INFO - PROCESS | 1645 | Full stack: 04:22:35 INFO - PROCESS | 1645 | ************************* 04:23:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 04:23:55 INFO - PROCESS | 1645 | RSS: Main: 262774784 04:23:55 INFO - PROCESS | 1645 | 04:26:56 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 04:26:57 INFO - PROCESS | 1645 | RSS: Main: 273797120 04:26:57 INFO - PROCESS | 1645 | 04:29:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 04:30:00 INFO - PROCESS | 1645 | RSS: Main: 267567104 04:30:00 INFO - PROCESS | 1645 | 04:33:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 04:33:03 INFO - PROCESS | 1645 | RSS: Main: 273051648 04:33:03 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 04:36:06 INFO - PROCESS | 1645 | RSS: Main: 275357696 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | __start_tp_report 04:36:06 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 04:36:06 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 04:36:06 INFO - PROCESS | 1645 | |i|pagename|runs| 04:36:06 INFO - PROCESS | 1645 | |0;dojo.html;3302.504624306354;3317.3862835375458;3341.198112453012;3355.3624811285854;3379.053864917824;5507.807226747064;5524.558035357172;5543.445655434454;5572.3034620672415;5572.888542229153;4505.5719706627815;5493.7802487900535;5581.748821303041;5657.462541058603;5721.628094173886;4807.903841923159;5066.06277838601;5090.185570308751;5184.922226166611;5194.428612852583;4986.127427700156;5178.352705911761;5251.186066159732;5259.737013149346;5304.655197412156;5056.266841308026;5063.8480845574695;5204.505571970657;5220.634555581111;5245.816396426145;5078.4159821620615;5128.1794912813775;5172.948270517322;5188.9740551297;5210.296609957645;5066.594672426234;5085.923711144335;5125.410577783566;5125.897482050375;5138.254953031789;3957.5053118360206;5062.417821950449;5552.972700050504;5638.097904335327;5642.351129620105;5980.820575382745;6053.576249662526;6104.246950856165;6113.385090541964;6128.136482154514;5197.870053248661;6166.414190651925;6183.165272688175;6220;6244.313125556185;5835.416458354131;5840.941590584082;5871.2073870027;5874.530037596982;5881.3530511643685;6104.762330457818;6160.537959653044;6176.752929882844;6199.845003874849;6253.405926436982;4968.403791544965;6099;6105.877882442415;6109.480694140959;6127.142200091991;6171.56799024073;6184.257889053252;6201.906971395432;6212.502999760099;6214.658193799384;5044.646874718735;6041.6375017499095;6079.513638908877;6107.633541987495;6113.263474096151;5027.773750181251;5812.622179558315;6206.689665516707;6213.254409470893;6215.192025036807;4908.092002979461;4969.130402179677;4985.601151907838;4991.151504244287;5014.197728363444;4371.30059190528;4385.583369579885;4411.801468933906;4421.469423669116;4431.40176076232;5685.431456854364;5711.628744131618;5738.282714660668;5761.596688231867;5780.855478613068;6180.938190618126;6181.165542651775;6223.564350495512;6240.375962403723;6260.436560709467;5564.888702225933;5599.216109744639;5693.800716974969;5703.486686198262;5705.771769129271;5376.46235376467;5394.974954758662;5417.241586177938;5443.945560544423;5475.151351540518;6261.154744109578;6261.436470717657;6272.749090036439;6285.905711414241;6331.113644089831;6128.503123582109;6178.907316390168;6240.781572645117;6256.937430625636;6276.435120839146;6143.542582966849;6188.783392581238;6209.906851397323;6236.719347629277;6255.343188965275;6156.138140660221;6157.168782214523;6161.383861613982;6176.227971503562;6186.319504854552;6237.906431403442;6253.155823963707;6258.655773932477;6271.686415679106;6276.089966954857;5845.561582881216;5954.821355359346;6022.367651396716;6050.6369617823075;6102.4507794298725;6075.726592303268;6110.7861224856915;6116.29662588808;6136.846578835565;6137.171481849893;4706.811727530998;5751.338596061507;5761.971190144022;5775.133729940375;5895.233619629421;5968.820935371946;6021.759129634941;6054.424829641177;6071.878562428815;6093.9085913712215;5936.287645482397;5950;5962.433568810956;5994.55040871945;6008.789692360747 04:36:06 INFO - PROCESS | 1645 | |1;ext.html;466.50783423488207;473.95492938071555;507.34299082687915;514.8790034341929;520.8255234496444;40597.98505037372;43273;43354;45592.77203613985;45682.77158614211;44089.559104408945;44500;44570.55429445705;44592.55407445924;44688.77655611726;8969.730908072768;9297.302702297338;9487.193588544982;9511.191548718367;9544.711463952382;11154.274972126826;11242.325460472397;11407.486663100139;11412.942935285311;11432.942835285812;9400.670976515823;11381.2033157679;11411.714707132305;11417.372044537547;11449.828252576219;9478.620855165786;11340.60307889224;11398.316101033965;11404.25872318305;11419.25774824642;11064.28082174656;11102.222844400896;11122.666320010412;11129.499172537255;11155.832662510069;36780.44829327562;37128;37150.814245928865;37418.62581374179;37559.81220093909;3925.6971505266442;3950;4002.779847108408;4048.7570745755056;4094.160697057126;24239.394015149584;29538.852305738335;29970;29993.850030749923;30014.399712005637;2631.657884475006;2827.9010234641687;2848.188266344082;3165.9366812663616;3337.4826901830256;417825;454713;489084.5545772284;490641;496163;58896;59087.40912590905;59215.40784592185;59252.70373648104;59285.40714592885;61322;61400;61408.07887881685;61700.07449888255;61994.69002655048;15625.531234062997;15788.92105539488;15809.4190580941;15875;15903.681926361409;11011.944940275247;11281.379524126252;12112.757744845054;12315.815262771066;12402.75194496105;18271.90864045698;18276.725849112274;18398.908005459885;18465.261389544266;18689.972051537297;7734.613269336511;7825.452218344775;7846.3330616897065;7859.6463159157975;7897.368210543143;744.0439035839029;782.9138794732575;823.8959793876235;828.9555160497816;890.7951171230653;25340.74659253384;25804.354891127496;26926.730732692813;31047.534286985712;31258;781.3358645151576;1058.116472745251;1091.879893211746;1094.261373572835;1210.3101232297506;16040.919795400949;16082;16187.028778273341;16242.593935151479;16327.428540001281;595670;597218;597662;600703;603174;63634.36365636377;64214.67892660507;64239.39401514906;64296;64529.064128076236;1230.6246594788674;1394.4213151542199;1431.0054512114189;1442.2067862675488;1447.3559266126472;21007.68488472705;29433.411331773674;30587.54118688266;30842.27044207515;31263.53104703477;54410;54443.45556544384;54689.72655136699;54820.72589637026;55083.72458137684;541958;543164;545587;547872;549620;23861.88069059713;24397.634035489125;26584.867075664497;27672.861635691694;27677.169684909484;37615.62384376121;47860;48694.75652621714;51099.23351149661;51560.22659660033;40512.59487405206;40640.59359406486;40880.59119408887;41107.7944610275;42302.153956921306;31322.686773131976;41034.1793164141;41497;41794.869248264615;42191;36155.55377784859;36585.817070914476;36702;36775.26449471049;37081.81459092687;24473.75526244786;25200.621990670523;32816.835915821226;33147.50278745773;33207.16982075467;23541.646875297225;24511.509769804146;24744;24800.751992479843;25231.864566094937 04:36:06 INFO - PROCESS | 1645 | |2;jquery.html;388.38441070902616;389.9044734040161;391.24684981410786;402.6517062740729;427.3057327695686;14871.033382830108;16064.598385040379;16193.757093643604;21218.46953826155;21296.680549791745;17413;21211.787882121174;21348.4662883428;22180.334589962287;22235.888820555916;5067.746612669361;5808.215890854723;6053.636781793084;6126.38736126386;6193;5252.395974462928;5815.185873977625;6039.607425517349;6092.756289748405;6126.295476020248;6029.698515074228;6036.3661815509395;6044.063170208625;6119.3880611938675;6124.387561243884;5977.671228082454;6036.39636036395;6089.360617135181;6110.144579758838;6122.785702500413;5956.37458066901;5960.284765828085;5982.940170598282;5991.91012134814;6045.516358691294;13328.733425331438;17180.570485737833;25218.36954076163;25973.22080337593;26278.343041423926;2627.7766389856884;2634.2360715392515;2700.6894207166233;2706.9458610827674;2714.6199532065525;10074.294799364048;10475.319104258275;10488.58045678172;14834.777478337834;15101.47144849936;1798.9622515276426;1843.8801477903894;1860.4232687866804;1862.2178684952216;1871.1860340751816;133709.66290336972;134275;147579;154099;158483;11896.226745261703;11958.162928594915;12068.250103735085;12113.636590902288;12200.267983920992;13206.745359190862;13815.792763108562;15378;15649.68700626004;15685.686286274438;8230.62962166704;8543.914560854437;8574.27118694918;8614.310855131574;8777.561121944005;7398.630068496554;8084.83830323402;8332.541710205996;8461.23848853606;8633.352498562634;3983.4423180754716;4744;4799.712017278975;4806;4884.877878053077;1740.7998080220684;2001.6697244954419;2026.9493262668257;2037.0934933954247;2053.938381848547;867.8847680730357;875.282268539804;892.2549671024767;903.3586153830854;911.343832440655;17542.649147017244;21202.04590793418;21291.46771330729;21295.041723122496;21840.453988650093;885.4377470306273;886.6763631274538;916.1479823763964;918.9770255743526;923.8568021956607;10785.78428431427;11123.888761112446;11154.721131971766;11168.497417616065;11180.944095279634;347761;399241;514247;711892;732901.670983294;119137;122474;137584.31207844097;158636.20681896748;162131;970.315927271272;975.5902520941222;1005.4570531912685;1008.2287050406445;1011.3224139826334;18488.260469581066;18681.43955681332;18699.532511687317;18741.90629046846;18829.623407532046;48551.51448485611;52895;60169.097463537204;60611.09083363841;61350.69324653348;85396.14603853882;87575;87746.56126719326;88965;89982;7688.6540105696495;8240.546769927712;8278.296344810758;8383.203595658402;8530.14698530142;10518.631847885288;12542;12905.773951474595;13299.468021279428;13302.866971330162;11054.170937179582;11508.309501429942;11532.308061516336;11569.36368499707;11589.478473468882;5285.995660824431;8357.080721120794;10908.727281818017;11386.259893106922;11536.653900383002;10676.092532134855;11474.483648235682;11545;12066.577669781867;12145.028397728338;6176.845578860385;8314.293285070837;8593.484390936565;8633.91366086331;8654.134586541295;8359.99680038375;11199.440027998731;11211.047060999907;11388.772224555296;11719.589814356457 04:36:06 INFO - PROCESS | 1645 | |3;mootools.html;1424.935877885495;1427.2578259305162;1432.3769160415227;1449.6665766873616;1457.1694134343425;7476.887846682291;7777.494462859924;8023.037235531737;8487.321014318855;8490.278326342268;8043.597820109;8252.092269850327;8299.709510167146;8412.831743365128;8432.578371081452;2302.5510025545027;2323.1288266899915;2329.813614910803;2334.7315058768204;2335.6730057791924;2074.1288658763356;2138.550904310097;2300.7469178390365;2338.0647740903605;2348.5420343033115;2239.8432109752243;2313.3291345509783;2316.3051084674617;2325.767423257678;2334.241371554243;2193.3748881568754;2207.172310383606;2213.612617791888;2231.3640612425543;2232.3414592695194;1669.4908053043816;2216.944576385587;2227.0646328542052;2254.9210777622707;2258.706368172127;7592.696292148307;8016.8396632067615;8419.158084191593;8451.915480845235;8485.151484851527;5084.669496482754;5244.082285600043;5252;5254.842354729364;5279.52484276417;3317.1209629448217;3479.443289073761;3498.615152333267;3501.1947252132154;3568.8044505090566;1201.7536405036947;1208.5347141350555;1237.2143688757703;1257.937103144839;1264.5890085722176;10621.893781062245;10758.139348852152;10782.245242833005;10801.621943232029;10803.135749140129;4364.476262848479;4664.300354946785;4720;4725.929111063337;4735.337052812609;9456.054394560626;9517.714468565953;9550.331476796697;9551.61793528265;9560.521973901277;5260.447652996457;5275.947240527622;5280.762365693553;5281.762320695578;5284.524392804589;4509.616682581952;4647.814087436533;4760.619150467955;4840.685355451955;4864.148773964613;3432.7768695034742;3661.139632186434;3862.575116737157;3873.1091848874917;3957.2876882160913;1172.2556176827775;1220.725336799231;1286.523986125121;1288.0790234981846;1295.1387327427344;760.0347558600546;763.1643350531159;786.3316181245896;809.6842231529708;850.5959669157224;4853.587445067209;5573.219749235111;5674.290713660793;5708.80019199326;5868.911966320508;844.801471654173;951.857221416793;1020.806046851096;1042.4943902207424;1042.7288904884633;3826.368649172911;3841.673457756066;3847;3914.432407300925;3929.9214015719526;9525.809483810284;10002;10014.39913605186;10023.14803241718;10052.246081543914;9962.452065136487;9964.20286377088;9965.850512242323;9974.401535907724;10002.749931251778;7394.889076663854;7663.846723065508;7850.293473587404;7854.057513098464;7961.960190199012;5744.224529688438;5751.626144300607;5885.499732522783;5945.672987985702;5988;8822.823543528964;9154.313426493172;9158.587863546023;9251.259899207913;9305.348625596414;9059.22996545301;9146.63413463454;9253.648311693429;9368.34421590482;9389.389689670423;7115.964420177866;7172.426205903411;7183.425325973805;7247.782566523013;7264.055672762507;7852.45032847718;7898.526088434713;7907.525548467111;7928.088269849041;7941.523508589503;7021.859562808818;7152.177499587406;7154.499185056996;7189.7483588074165;7267.236940121211;6256.593321434092;6970;6975.8256043597285;7010.123734533184;7029.929700703132;6218;6361.809145725636;6420.229572451336;6430.614163150226;6478.060681201294;4608.824749688808;5031.496850315086;5067.923981140212;5074.898502029865;5151.150060240018;4344.283193273074;4807.95192048075;4973.303737476684;5072.365954255718;5213.869653258699 04:36:06 INFO - PROCESS | 1645 | |4;prototype.html;353.99115022124425;361.9420892657175;364.86499995001844;374.29819089207734;376.8304263081614;4812.518748125186;5155.587552995761;5242.8165014224505;5438.184272359148;5532.640378375408;5262.421133675302;5399.40606533282;5457.754401051952;5536.2249285100015;5552;3283.6387997320276;4027.8791636250958;4232.111256636094;4239.6396306314;4330.285502892019;4167.895802604929;4173.937390939123;4176.102138040321;4183.97908010461;4184.7907604619795;3664.59689434162;4118.320477121287;4153.8338466461455;4162.854300099497;4179.728317659343;3826.6747326477284;4167.83328666853;4171.97914010428;4176.185643799445;4184.456020717303;3253.1541799132397;3255.9023229303157;3522.7534072614926;3575.5173051637958;3575.8390872410805;4929.8028078876805;5411.756470958816;5433.592480563973;5443.319585051869;5467.699276539789;4436.911261774779;4796.400449943757;4801.615870730333;4806.567408933178;4808.519148085198;4527.660425468071;5294.073537131025;5352.812651557177;5752.0796672532615;5804.854878628068;3208.743300535975;3683.526589364249;3940.7931558327427;3955.4462375267485;3958.34687276599;5178.922316165261;5368.677879327252;5607.859803504904;5859.53123750099;6170.136180934673;3343.2811945431363;3789.488419063391;3891.610838916086;3940.862069827542;3987.980060099681;3474.9575127461662;3477.217626034122;4088.2232375848494;4115.36211887158;4126.855560055384;4181.519125300569;4216.91566168681;4579.564941330568;4811.27830825372;4823.5658790709;4696.7416792076765;4879.3163759931895;5323.86690332737;5530.281063461724;5852.970735146297;1225.3995542184266;1302.3032677517483;1307.7776777947772;1314.7633425983415;1320.3398300849576;781.7576551269011;794.2216627704881;830.667732906842;879.7668617816283;890.3366991591306;4525.208088584484;4788.880277993008;4927.90144197114;5056.696598204119;5250.396204436539;5182.714950677673;5343.812966546152;5451.563874889999;5675.764814056031;5855.677937713382;4159.521655009652;4633.389777171668;4698.88252793676;5034.572061374751;5171.301874247004;2586.784211420629;2959.5054497478636;3039.7568194544383;3066.3100802319746;3077.215310095956;5195.571217915103;5781.855453613609;5997.220361352996;6016.067509536029;6060.878782424415;4847.891167342217;5206.661566998133;5262.736863156827;5411.672980618372;5929.805971790465;4980.427250866197;5117;5459.945400545944;5710.914926164016;6098.597322615823;4804.543568361;4944.406671199479;5551.3638566738855;5778.508826749605;5783.219265399117;5358.517733404013;5424.484673955968;5895.322037965689;5950.553708471795;5959.523238141025;5831.4168583141345;6215.223097112861;6241.188645476059;6247.687615619292;6261.279952805304;3391.608915714366;3457.4468085106264;3697.0018095114706;3857.209272099157;3932.233214523255;5193.467926961631;5204.427512973494;5762.801645087017;5972.372900845522;6006.399360063959;4944.678595891256;5686.829395117988;5707.828765137053;5911.408859114226;5966.075258334965;5014.448410674896;5481.616286859881;5805.187273781589;5818.418158184148;5875.441833025856;5515.393306736336;5542.3349198094875;5585.916211256753;5676.262085928803;5771.480566749013;4890.731009794496;5005.899882002267;5892.440218179266;5908.881822363614;5931.7627294907725;4151.107511884959;4557.726536407826;5732.398098199796;5806.16792916673;5832.825015249549 04:36:06 INFO - PROCESS | 1645 | |5;yui.html;697.6023666510088;706.8020954132844;742.8922806193101;769.3422124083908;849.5497386385216;12877.806832897502;14790.18653974031;15392.923035384836;15609.999999999985;15745.134017629025;14678.926605366985;14786.334614942354;14792.964492485504;14808.851911480882;14812.407503699866;878.3544095090103;883.7658020624508;893.6425429828056;895.7044175422095;896.7399454158286;730.514208051645;879.2174964281794;884.2572239318971;893.1202765276198;894.3739382432324;909.522500687138;937.8780758501385;941.1717688434203;941.7033634405141;942.6276620734806;914.5015966298383;927.9953600232024;932.8507438809758;933.4352716606423;935.4200395754642;684.0662495693343;694.2224708326706;696.0186137546036;696.9686364113627;697.292248367907;13409.865901341056;13614;13763.036587438883;13765.931170344184;13897.444102235899;11907.16649834512;11996.580119695856;12027.398630068461;12102.636920892388;12461.875381246162;10556.841647375295;10765.192610554239;10799.460026998619;10881.401522916236;11123.888761112446;3589.569251689814;3673;3678.9264214715554;3759.56764972029;3801.6768574671187;104100.47949760279;108599;108652.45673771581;110155;110473;8775.341849361323;9046.366754327133;9134.680286189952;9141.771455713528;9176;19387.4183774487;19862.404127876187;19888.303909363392;19920.3027894023;19920.70118948217;7275.599842008634;7386.168822456643;7513.023306970059;7626.542407455459;7906.644201010853;4237.322028475429;4263.317869140985;4279.550647182001;4314.22343978087;4314.41755363022;3430.7255419566377;3490;3509.771864828829;3517.9973707493755;3525.1715846775987;626.7148447456397;630.2374127306011;631.4443289904855;641.746510128506;650.2652003236312;610.4018062298971;610.71906922816;635.9491240700733;646.8647523596059;654.4339146638124;9382.812343753087;9701.272404569685;9771.609135634637;9985.500724963722;10161.491925403849;567.2314014510279;627.1408170805934;645.6223109480912;663.9070530125787;686.4954258620011;4500.122476117126;4738.099761045391;4744.525547445228;4747.382840230817;4750.738709371018;103749.53224398154;108846;111074.88925110808;111492;112294;71086.64456677684;76472.70581882552;77180;79231;100212.49893750485;77412;79351.60324198457;80380;80526.19473805305;82412;10858.67423977282;10905.672829815117;11212.43937803123;11215;11236.55053797839;41805;46940.765296173304;47351.52648473471;49954;54271;68957.31042689508;69506;71020.28979710137;71634;72542;11937.104717146423;12647.494100235888;12957.740845183233;13114.672133196746;13177.407016684081;14214.395572124513;14701.41194352214;14844.183569903758;15118.546443606709;15144.848551514344;13409.798853017408;13552.457901683822;13617.591472255848;13645.454181832616;13788.793168102286;13506.729865402833;13607.727845442838;13675;13751.381187846371;14047.227402492961;11596.76806463849;13240.933795330962;13438.932805336302;13463.932680336928;13649.976251780958;10371.429571373646;10791.838122428328;10992.340459572451;11128.332300062022;11547.826782598437;7596.8480630388185;7926;9983.500824958577;10944.835827462754;11010.229283950046 04:36:06 INFO - PROCESS | 1645 | __end_tp_report 04:36:06 INFO - PROCESS | 1645 | __start_cc_report 04:36:06 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,383 04:36:06 INFO - PROCESS | 1645 | __end_cc_report 04:36:06 INFO - PROCESS | 1645 | __startTimestamp1485866166482__endTimestamp 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | ------- Summary: start ------- 04:36:06 INFO - PROCESS | 1645 | Number of tests: 6 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5646.73 Median:5871.21 stddev:661.76 (11.3%) stddev-sans-first:637.72 04:36:06 INFO - PROCESS | 1645 | Values: 3302.5 3317.4 3341.2 3355.4 3379.1 5507.8 5524.6 5543.4 5572.3 5572.9 4505.6 5493.8 5581.7 5657.5 5721.6 4807.9 5066.1 5090.2 5184.9 5194.4 4986.1 5178.4 5251.2 5259.7 5304.7 5056.3 5063.8 5204.5 5220.6 5245.8 5078.4 5128.2 5172.9 5189.0 5210.3 5066.6 5085.9 5125.4 5125.9 5138.3 3957.5 5062.4 5553.0 5638.1 5642.4 5980.8 6053.6 6104.2 6113.4 6128.1 5197.9 6166.4 6183.2 6220.0 6244.3 5835.4 5840.9 5871.2 5874.5 5881.4 6104.8 6160.5 6176.8 6199.8 6253.4 4968.4 6099.0 6105.9 6109.5 6127.1 6171.6 6184.3 6201.9 6212.5 6214.7 5044.6 6041.6 6079.5 6107.6 6113.3 5027.8 5812.6 6206.7 6213.3 6215.2 4908.1 4969.1 4985.6 4991.2 5014.2 4371.3 4385.6 4411.8 4421.5 4431.4 5685.4 5711.6 5738.3 5761.6 5780.9 6180.9 6181.2 6223.6 6240.4 6260.4 5564.9 5599.2 5693.8 5703.5 5705.8 5376.5 5395.0 5417.2 5443.9 5475.2 6261.2 6261.4 6272.7 6285.9 6331.1 6128.5 6178.9 6240.8 6256.9 6276.4 6143.5 6188.8 6209.9 6236.7 6255.3 6156.1 6157.2 6161.4 6176.2 6186.3 6237.9 6253.2 6258.7 6271.7 6276.1 5845.6 5954.8 6022.4 6050.6 6102.5 6075.7 6110.8 6116.3 6136.8 6137.2 4706.8 5751.3 5762.0 5775.1 5895.2 5968.8 6021.8 6054.4 6071.9 6093.9 5936.3 5950.0 5962.4 5994.6 6008.8 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:67897.15 Median:37284.72 stddev:144238.02 (386.9%) stddev-sans-first:144553.80 04:36:06 INFO - PROCESS | 1645 | Values: 466.5 474.0 507.3 514.9 520.8 40598.0 43273.0 43354.0 45592.8 45682.8 44089.6 44500.0 44570.6 44592.6 44688.8 8969.7 9297.3 9487.2 9511.2 9544.7 11154.3 11242.3 11407.5 11412.9 11432.9 9400.7 11381.2 11411.7 11417.4 11449.8 9478.6 11340.6 11398.3 11404.3 11419.3 11064.3 11102.2 11122.7 11129.5 11155.8 36780.4 37128.0 37150.8 37418.6 37559.8 3925.7 3950.0 4002.8 4048.8 4094.2 24239.4 29538.9 29970.0 29993.9 30014.4 2631.7 2827.9 2848.2 3165.9 3337.5 417825.0 454713.0 489084.6 490641.0 496163.0 58896.0 59087.4 59215.4 59252.7 59285.4 61322.0 61400.0 61408.1 61700.1 61994.7 15625.5 15788.9 15809.4 15875.0 15903.7 11011.9 11281.4 12112.8 12315.8 12402.8 18271.9 18276.7 18398.9 18465.3 18690.0 7734.6 7825.5 7846.3 7859.6 7897.4 744.0 782.9 823.9 829.0 890.8 25340.7 25804.4 26926.7 31047.5 31258.0 781.3 1058.1 1091.9 1094.3 1210.3 16040.9 16082.0 16187.0 16242.6 16327.4 595670.0 597218.0 597662.0 600703.0 603174.0 63634.4 64214.7 64239.4 64296.0 64529.1 1230.6 1394.4 1431.0 1442.2 1447.4 21007.7 29433.4 30587.5 30842.3 31263.5 54410.0 54443.5 54689.7 54820.7 55083.7 541958.0 543164.0 545587.0 547872.0 549620.0 23861.9 24397.6 26584.9 27672.9 27677.2 37615.6 47860.0 48694.8 51099.2 51560.2 40512.6 40640.6 40880.6 41107.8 42302.2 31322.7 41034.2 41497.0 41794.9 42191.0 36155.6 36585.8 36702.0 36775.3 37081.8 24473.8 25200.6 32816.8 33147.5 33207.2 23541.6 24511.5 24744.0 24800.8 25231.9 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:34841.45 Median:14456.29 stddev:96017.51 (664.2%) stddev-sans-first:96252.02 04:36:06 INFO - PROCESS | 1645 | Values: 388.4 389.9 391.2 402.7 427.3 14871.0 16064.6 16193.8 21218.5 21296.7 17413.0 21211.8 21348.5 22180.3 22235.9 5067.7 5808.2 6053.6 6126.4 6193.0 5252.4 5815.2 6039.6 6092.8 6126.3 6029.7 6036.4 6044.1 6119.4 6124.4 5977.7 6036.4 6089.4 6110.1 6122.8 5956.4 5960.3 5982.9 5991.9 6045.5 13328.7 17180.6 25218.4 25973.2 26278.3 2627.8 2634.2 2700.7 2706.9 2714.6 10074.3 10475.3 10488.6 14834.8 15101.5 1799.0 1843.9 1860.4 1862.2 1871.2 133709.7 134275.0 147579.0 154099.0 158483.0 11896.2 11958.2 12068.3 12113.6 12200.3 13206.7 13815.8 15378.0 15649.7 15685.7 8230.6 8543.9 8574.3 8614.3 8777.6 7398.6 8084.8 8332.5 8461.2 8633.4 3983.4 4744.0 4799.7 4806.0 4884.9 1740.8 2001.7 2026.9 2037.1 2053.9 867.9 875.3 892.3 903.4 911.3 17542.6 21202.0 21291.5 21295.0 21840.5 885.4 886.7 916.1 919.0 923.9 10785.8 11123.9 11154.7 11168.5 11180.9 347761.0 399241.0 514247.0 711892.0 732901.7 119137.0 122474.0 137584.3 158636.2 162131.0 970.3 975.6 1005.5 1008.2 1011.3 18488.3 18681.4 18699.5 18741.9 18829.6 48551.5 52895.0 60169.1 60611.1 61350.7 85396.1 87575.0 87746.6 88965.0 89982.0 7688.7 8240.5 8278.3 8383.2 8530.1 10518.6 12542.0 12905.8 13299.5 13302.9 11054.2 11508.3 11532.3 11569.4 11589.5 5286.0 8357.1 10908.7 11386.3 11536.7 10676.1 11474.5 11545.0 12066.6 12145.0 6176.8 8314.3 8593.5 8633.9 8654.1 8360.0 11199.4 11211.0 11388.8 11719.6 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5429.86 Median:5248.04 stddev:2954.25 (56.3%) stddev-sans-first:2947.20 04:36:06 INFO - PROCESS | 1645 | Values: 1424.9 1427.3 1432.4 1449.7 1457.2 7476.9 7777.5 8023.0 8487.3 8490.3 8043.6 8252.1 8299.7 8412.8 8432.6 2302.6 2323.1 2329.8 2334.7 2335.7 2074.1 2138.6 2300.7 2338.1 2348.5 2239.8 2313.3 2316.3 2325.8 2334.2 2193.4 2207.2 2213.6 2231.4 2232.3 1669.5 2216.9 2227.1 2254.9 2258.7 7592.7 8016.8 8419.2 8451.9 8485.2 5084.7 5244.1 5252.0 5254.8 5279.5 3317.1 3479.4 3498.6 3501.2 3568.8 1201.8 1208.5 1237.2 1257.9 1264.6 10621.9 10758.1 10782.2 10801.6 10803.1 4364.5 4664.3 4720.0 4725.9 4735.3 9456.1 9517.7 9550.3 9551.6 9560.5 5260.4 5275.9 5280.8 5281.8 5284.5 4509.6 4647.8 4760.6 4840.7 4864.1 3432.8 3661.1 3862.6 3873.1 3957.3 1172.3 1220.7 1286.5 1288.1 1295.1 760.0 763.2 786.3 809.7 850.6 4853.6 5573.2 5674.3 5708.8 5868.9 844.8 951.9 1020.8 1042.5 1042.7 3826.4 3841.7 3847.0 3914.4 3929.9 9525.8 10002.0 10014.4 10023.1 10052.2 9962.5 9964.2 9965.9 9974.4 10002.7 7394.9 7663.8 7850.3 7854.1 7962.0 5744.2 5751.6 5885.5 5945.7 5988.0 8822.8 9154.3 9158.6 9251.3 9305.3 9059.2 9146.6 9253.6 9368.3 9389.4 7116.0 7172.4 7183.4 7247.8 7264.1 7852.5 7898.5 7907.5 7928.1 7941.5 7021.9 7152.2 7154.5 7189.7 7267.2 6256.6 6970.0 6975.8 7010.1 7029.9 6218.0 6361.8 6420.2 6430.6 6478.1 4608.8 5031.5 5067.9 5074.9 5151.2 4344.3 4808.0 4973.3 5072.4 5213.9 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4557.16 Median:5024.51 stddev:1411.46 (28.1%) stddev-sans-first:1379.71 04:36:06 INFO - PROCESS | 1645 | Values: 354.0 361.9 364.9 374.3 376.8 4812.5 5155.6 5242.8 5438.2 5532.6 5262.4 5399.4 5457.8 5536.2 5552.0 3283.6 4027.9 4232.1 4239.6 4330.3 4167.9 4173.9 4176.1 4184.0 4184.8 3664.6 4118.3 4153.8 4162.9 4179.7 3826.7 4167.8 4172.0 4176.2 4184.5 3253.2 3255.9 3522.8 3575.5 3575.8 4929.8 5411.8 5433.6 5443.3 5467.7 4436.9 4796.4 4801.6 4806.6 4808.5 4527.7 5294.1 5352.8 5752.1 5804.9 3208.7 3683.5 3940.8 3955.4 3958.3 5178.9 5368.7 5607.9 5859.5 6170.1 3343.3 3789.5 3891.6 3940.9 3988.0 3475.0 3477.2 4088.2 4115.4 4126.9 4181.5 4216.9 4579.6 4811.3 4823.6 4696.7 4879.3 5323.9 5530.3 5853.0 1225.4 1302.3 1307.8 1314.8 1320.3 781.8 794.2 830.7 879.8 890.3 4525.2 4788.9 4927.9 5056.7 5250.4 5182.7 5343.8 5451.6 5675.8 5855.7 4159.5 4633.4 4698.9 5034.6 5171.3 2586.8 2959.5 3039.8 3066.3 3077.2 5195.6 5781.9 5997.2 6016.1 6060.9 4847.9 5206.7 5262.7 5411.7 5929.8 4980.4 5117.0 5459.9 5710.9 6098.6 4804.5 4944.4 5551.4 5778.5 5783.2 5358.5 5424.5 5895.3 5950.6 5959.5 5831.4 6215.2 6241.2 6247.7 6261.3 3391.6 3457.4 3697.0 3857.2 3932.2 5193.5 5204.4 5762.8 5972.4 6006.4 4944.7 5686.8 5707.8 5911.4 5966.1 5014.4 5481.6 5805.2 5818.4 5875.4 5515.4 5542.3 5585.9 5676.3 5771.5 4890.7 5005.9 5892.4 5908.9 5931.8 4151.1 4557.7 5732.4 5806.2 5832.8 04:36:06 INFO - PROCESS | 1645 | 04:36:06 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20351.47 Median:4250.32 stddev:29929.39 (704.2%) stddev-sans-first:29976.97 04:36:06 INFO - PROCESS | 1645 | Values: 697.6 706.8 742.9 769.3 849.5 12877.8 14790.2 15392.9 15610.0 15745.1 14678.9 14786.3 14793.0 14808.9 14812.4 878.4 883.8 893.6 895.7 896.7 730.5 879.2 884.3 893.1 894.4 909.5 937.9 941.2 941.7 942.6 914.5 928.0 932.9 933.4 935.4 684.1 694.2 696.0 697.0 697.3 13409.9 13614.0 13763.0 13765.9 13897.4 11907.2 11996.6 12027.4 12102.6 12461.9 10556.8 10765.2 10799.5 10881.4 11123.9 3589.6 3673.0 3678.9 3759.6 3801.7 104100.5 108599.0 108652.5 110155.0 110473.0 8775.3 9046.4 9134.7 9141.8 9176.0 19387.4 19862.4 19888.3 19920.3 19920.7 7275.6 7386.2 7513.0 7626.5 7906.6 4237.3 4263.3 4279.6 4314.2 4314.4 3430.7 3490.0 3509.8 3518.0 3525.2 626.7 630.2 631.4 641.7 650.3 610.4 610.7 635.9 646.9 654.4 9382.8 9701.3 9771.6 9985.5 10161.5 567.2 627.1 645.6 663.9 686.5 4500.1 4738.1 4744.5 4747.4 4750.7 103749.5 108846.0 111074.9 111492.0 112294.0 71086.6 76472.7 77180.0 79231.0 100212.5 77412.0 79351.6 80380.0 80526.2 82412.0 10858.7 10905.7 11212.4 11215.0 11236.6 41805.0 46940.8 47351.5 49954.0 54271.0 68957.3 69506.0 71020.3 71634.0 72542.0 11937.1 12647.5 12957.7 13114.7 13177.4 14214.4 14701.4 14844.2 15118.5 15144.8 13409.8 13552.5 13617.6 13645.5 13788.8 13506.7 13607.7 13675.0 13751.4 14047.2 11596.8 13240.9 13438.9 13463.9 13650.0 10371.4 10791.8 10992.3 11128.3 11547.8 7596.8 7926.0 9983.5 10944.8 11010.2 04:36:06 INFO - PROCESS | 1645 | -------- Summary: end -------- 04:36:06 INFO - PROCESS | 1645 | 04:36:07 INFO - TEST-INFO | 1645: exit 0 04:36:07 INFO - TEST-OK | dromaeo_css | took 1115783ms 04:36:07 INFO - TEST-START | kraken 04:36:07 INFO - operating with platform_type : mac_ 04:36:07 INFO - Initialising browser for kraken test... 04:36:07 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp1SWmto/profile http://localhost:49250/getInfo.html) 04:36:10 INFO - PROCESS | 1657 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:36:10 INFO - PROCESS | 1657 | 2017-01-31 04:36:10.375 plugin-container[1659:9785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:36:10 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:10 INFO - PROCESS | 1657 | 2017-01-31 04:36:10.376 plugin-container[1659:9785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 04:36:10 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:10 INFO - PROCESS | 1657 | 2017-01-31 04:36:10.376 plugin-container[1659:9785] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:10 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 04:36:10 INFO - PROCESS | 1657 | colorDepth:24 04:36:10 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 04:36:10 INFO - PROCESS | 1657 | __metrics 04:36:10 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3284: TypeError: this.tabs is undefined 04:36:10 INFO - PROCESS | 1657 | 1485866170536 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp1SWmto/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp1SWmto/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp1SWmto/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp1SWmto/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:36:11 INFO - TEST-INFO | 1657: exit 0 04:36:11 INFO - Browser initialized. 04:36:11 INFO - Running cycle 1/1 for kraken test... 04:36:11 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp1SWmto/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:13 INFO - PROCESS | 1660 | 2017-01-31 04:36:13.777 plugin-container[1661:9901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 04:36:13 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:13 INFO - PROCESS | 1660 | 2017-01-31 04:36:13.778 plugin-container[1661:9901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 04:36:13 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:13 INFO - PROCESS | 1660 | 2017-01-31 04:36:13.778 plugin-container[1661:9901] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:23 INFO - PROCESS | 1660 | RSS: Main: 233869312 04:36:23 INFO - PROCESS | 1660 | 04:36:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:27 INFO - PROCESS | 1660 | RSS: Main: 247599104 04:36:27 INFO - PROCESS | 1660 | 04:36:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 04:36:30 INFO - PROCESS | 1660 | RSS: Main: 255471616 04:36:30 INFO - PROCESS | 1660 | 04:36:34 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 04:36:34 INFO - PROCESS | 1660 | RSS: Main: 258105344 04:36:34 INFO - PROCESS | 1660 | 04:36:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 04:36:37 INFO - PROCESS | 1660 | RSS: Main: 259309568 04:36:37 INFO - PROCESS | 1660 | 04:36:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:39 INFO - PROCESS | 1660 | RSS: Main: 259731456 04:36:39 INFO - PROCESS | 1660 | 04:36:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:43 INFO - PROCESS | 1660 | RSS: Main: 266817536 04:36:43 INFO - PROCESS | 1660 | 04:36:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:46 INFO - PROCESS | 1660 | RSS: Main: 265920512 04:36:46 INFO - PROCESS | 1660 | 04:36:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 04:36:50 INFO - PROCESS | 1660 | RSS: Main: 265990144 04:36:50 INFO - PROCESS | 1660 | 04:36:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:52 INFO - PROCESS | 1660 | RSS: Main: 265310208 04:36:52 INFO - PROCESS | 1660 | 04:36:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:55 INFO - PROCESS | 1660 | RSS: Main: 265449472 04:36:55 INFO - PROCESS | 1660 | 04:36:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:58 INFO - PROCESS | 1660 | RSS: Main: 265506816 04:36:58 INFO - PROCESS | 1660 | 04:37:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:01 INFO - PROCESS | 1660 | RSS: Main: 265760768 04:37:01 INFO - PROCESS | 1660 | 04:37:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:05 INFO - PROCESS | 1660 | RSS: Main: 265842688 04:37:05 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 04:37:07 INFO - PROCESS | 1660 | RSS: Main: 267960320 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | __start_tp_report 04:37:07 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 04:37:07 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 04:37:07 INFO - PROCESS | 1660 | |i|pagename|runs| 04:37:07 INFO - PROCESS | 1660 | |0;ai-astar;106;116;118;118;117;144;174;118;117;116 04:37:07 INFO - PROCESS | 1660 | |1;audio-beat-detection;143;112;110;159;113;118;101;142;165;144 04:37:07 INFO - PROCESS | 1660 | |2;audio-dft;210;211;205;199;196;196;195;197;199;189 04:37:07 INFO - PROCESS | 1660 | |3;audio-fft;88;60;59;85;60;61;62;67;93;53 04:37:07 INFO - PROCESS | 1660 | |4;audio-oscillator;89;71;85;104;100;106;92;69;70;83 04:37:07 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;89;101;89;87;90;86;90;87;89;86 04:37:07 INFO - PROCESS | 1660 | |6;imaging-darkroom;100;101;99;99;99;98;100;110;99;99 04:37:07 INFO - PROCESS | 1660 | |7;imaging-desaturate;108;117;92;91;92;93;93;92;93;91 04:37:07 INFO - PROCESS | 1660 | |8;json-parse-financial;64;63;62;64;63;63;65;67;64;64 04:37:07 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;70;76;108;118;116;79;72;75;72;72 04:37:07 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;74;82;82;102;110;115;95;90;89;92 04:37:07 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;151;160;141;142;152;151;128;176;199;201 04:37:07 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;175;178;242;190;178;174;177;178;175;175 04:37:07 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;73;81;79;86;68;63;73;88;89;88 04:37:07 INFO - PROCESS | 1660 | __end_tp_report 04:37:07 INFO - PROCESS | 1660 | __start_cc_report 04:37:07 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,937 04:37:07 INFO - PROCESS | 1660 | __end_cc_report 04:37:07 INFO - PROCESS | 1660 | __startTimestamp1485866227677__endTimestamp 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | ------- Summary: start ------- 04:37:07 INFO - PROCESS | 1660 | Number of tests: 14 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:124.40 Median:118.00 stddev:19.88 (16.8%) stddev-sans-first:19.94 04:37:07 INFO - PROCESS | 1660 | Values: 106.0 116.0 118.0 118.0 117.0 144.0 174.0 118.0 117.0 116.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:142.50 stddev:22.53 (15.8%) stddev-sans-first:23.45 04:37:07 INFO - PROCESS | 1660 | Values: 143.0 112.0 110.0 159.0 113.0 118.0 101.0 142.0 165.0 144.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:199.70 Median:199.00 stddev:6.95 (3.5%) stddev-sans-first:6.29 04:37:07 INFO - PROCESS | 1660 | Values: 210.0 211.0 205.0 199.0 196.0 196.0 195.0 197.0 199.0 189.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:68.80 Median:64.50 stddev:14.25 (22.1%) stddev-sans-first:13.31 04:37:07 INFO - PROCESS | 1660 | Values: 88.0 60.0 59.0 85.0 60.0 61.0 62.0 67.0 93.0 53.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:77.00 stddev:13.89 (18.0%) stddev-sans-first:14.71 04:37:07 INFO - PROCESS | 1660 | Values: 89.0 71.0 85.0 104.0 100.0 106.0 92.0 69.0 70.0 83.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:89.00 stddev:4.35 (4.9%) stddev-sans-first:4.61 04:37:07 INFO - PROCESS | 1660 | Values: 89.0 101.0 89.0 87.0 90.0 86.0 90.0 87.0 89.0 86.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:99.00 stddev:3.47 (3.5%) stddev-sans-first:3.68 04:37:07 INFO - PROCESS | 1660 | Values: 100.0 101.0 99.0 99.0 99.0 98.0 100.0 110.0 99.0 99.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:92.00 stddev:8.88 (9.7%) stddev-sans-first:8.33 04:37:07 INFO - PROCESS | 1660 | Values: 108.0 117.0 92.0 91.0 92.0 93.0 93.0 92.0 93.0 91.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 04:37:07 INFO - PROCESS | 1660 | Values: 64.0 63.0 62.0 64.0 63.0 63.0 65.0 67.0 64.0 64.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:85.80 Median:72.00 stddev:19.78 (27.5%) stddev-sans-first:20.14 04:37:07 INFO - PROCESS | 1660 | Values: 70.0 76.0 108.0 118.0 116.0 79.0 72.0 75.0 72.0 72.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:85.50 stddev:12.85 (15.0%) stddev-sans-first:11.63 04:37:07 INFO - PROCESS | 1660 | Values: 74.0 82.0 82.0 102.0 110.0 115.0 95.0 90.0 89.0 92.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:160.10 Median:156.00 stddev:24.48 (15.7%) stddev-sans-first:25.74 04:37:07 INFO - PROCESS | 1660 | Values: 151.0 160.0 141.0 142.0 152.0 151.0 128.0 176.0 199.0 201.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:178.00 stddev:20.82 (11.7%) stddev-sans-first:21.81 04:37:07 INFO - PROCESS | 1660 | Values: 175.0 178.0 242.0 190.0 178.0 174.0 177.0 178.0 175.0 175.0 04:37:07 INFO - PROCESS | 1660 | 04:37:07 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:83.50 stddev:9.21 (11.0%) stddev-sans-first:9.53 04:37:07 INFO - PROCESS | 1660 | Values: 73.0 81.0 79.0 86.0 68.0 63.0 73.0 88.0 89.0 88.0 04:37:07 INFO - PROCESS | 1660 | -------- Summary: end -------- 04:37:07 INFO - PROCESS | 1660 | 04:37:08 INFO - TEST-INFO | 1660: exit 0 04:37:08 INFO - TEST-OK | kraken | took 61273ms 04:37:08 INFO - SUITE-END | took 1177s 04:37:08 INFO - Completed test suite (00:19:37) 04:37:08 INFO - javascript benchmark 04:37:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7258.881545782087, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.504624306354, 3317.3862835375458, 3341.198112453012, 3355.3624811285854, 3379.053864917824, 5507.807226747064, 5524.558035357172, 5543.445655434454, 5572.3034620672415, 5572.888542229153, 4505.5719706627815, 5493.7802487900535, 5581.748821303041, 5657.462541058603, 5721.628094173886, 4807.903841923159, 5066.06277838601, 5090.185570308751, 5184.922226166611, 5194.428612852583, 4986.127427700156, 5178.352705911761, 5251.186066159732, 5259.737013149346, 5304.655197412156, 5056.266841308026, 5063.8480845574695, 5204.505571970657, 5220.634555581111, 5245.816396426145, 5078.4159821620615, 5128.1794912813775, 5172.948270517322, 5188.9740551297, 5210.296609957645, 5066.594672426234, 5085.923711144335, 5125.410577783566, 5125.897482050375, 5138.254953031789, 3957.5053118360206, 5062.417821950449, 5552.972700050504, 5638.097904335327, 5642.351129620105, 5980.820575382745, 6053.576249662526, 6104.246950856165, 6113.385090541964, 6128.136482154514, 5197.870053248661, 6166.414190651925, 6183.165272688175, 6220.0, 6244.313125556185, 5835.416458354131, 5840.941590584082, 5871.2073870027, 5874.530037596982, 5881.3530511643685, 6104.762330457818, 6160.537959653044, 6176.752929882844, 6199.845003874849, 6253.405926436982, 4968.403791544965, 6099.0, 6105.877882442415, 6109.480694140959, 6127.142200091991, 6171.56799024073, 6184.257889053252, 6201.906971395432, 6212.502999760099, 6214.658193799384, 5044.646874718735, 6041.6375017499095, 6079.513638908877, 6107.633541987495, 6113.263474096151, 5027.773750181251, 5812.622179558315, 6206.689665516707, 6213.254409470893, 6215.192025036807, 4908.092002979461, 4969.130402179677, 4985.601151907838, 4991.151504244287, 5014.197728363444, 4371.30059190528, 4385.583369579885, 4411.801468933906, 4421.469423669116, 4431.40176076232, 5685.431456854364, 5711.628744131618, 5738.282714660668, 5761.596688231867, 5780.855478613068, 6180.938190618126, 6181.165542651775, 6223.564350495512, 6240.375962403723, 6260.436560709467, 5564.888702225933, 5599.216109744639, 5693.800716974969, 5703.486686198262, 5705.771769129271, 5376.46235376467, 5394.974954758662, 5417.241586177938, 5443.945560544423, 5475.151351540518, 6261.154744109578, 6261.436470717657, 6272.749090036439, 6285.905711414241, 6331.113644089831, 6128.503123582109, 6178.907316390168, 6240.781572645117, 6256.937430625636, 6276.435120839146, 6143.542582966849, 6188.783392581238, 6209.906851397323, 6236.719347629277, 6255.343188965275, 6156.138140660221, 6157.168782214523, 6161.383861613982, 6176.227971503562, 6186.319504854552, 6237.906431403442, 6253.155823963707, 6258.655773932477, 6271.686415679106, 6276.089966954857, 5845.561582881216, 5954.821355359346, 6022.367651396716, 6050.6369617823075, 6102.4507794298725, 6075.726592303268, 6110.7861224856915, 6116.29662588808, 6136.846578835565, 6137.171481849893, 4706.811727530998, 5751.338596061507, 5761.971190144022, 5775.133729940375, 5895.233619629421, 5968.820935371946, 6021.759129634941, 6054.424829641177, 6071.878562428815, 6093.9085913712215, 5936.287645482397, 5950.0, 5962.433568810956, 5994.55040871945, 6008.789692360747], "value": 5606.518097693487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.50783423488207, 473.95492938071555, 507.34299082687915, 514.8790034341929, 520.8255234496444, 40597.98505037372, 43273.0, 43354.0, 45592.77203613985, 45682.77158614211, 44089.559104408945, 44500.0, 44570.55429445705, 44592.55407445924, 44688.77655611726, 8969.730908072768, 9297.302702297338, 9487.193588544982, 9511.191548718367, 9544.711463952382, 11154.274972126826, 11242.325460472397, 11407.486663100139, 11412.942935285311, 11432.942835285812, 9400.670976515823, 11381.2033157679, 11411.714707132305, 11417.372044537547, 11449.828252576219, 9478.620855165786, 11340.60307889224, 11398.316101033965, 11404.25872318305, 11419.25774824642, 11064.28082174656, 11102.222844400896, 11122.666320010412, 11129.499172537255, 11155.832662510069, 36780.44829327562, 37128.0, 37150.814245928865, 37418.62581374179, 37559.81220093909, 3925.6971505266442, 3950.0, 4002.779847108408, 4048.7570745755056, 4094.160697057126, 24239.394015149584, 29538.852305738335, 29970.0, 29993.850030749923, 30014.399712005637, 2631.657884475006, 2827.9010234641687, 2848.188266344082, 3165.9366812663616, 3337.4826901830256, 417825.0, 454713.0, 489084.5545772284, 490641.0, 496163.0, 58896.0, 59087.40912590905, 59215.40784592185, 59252.70373648104, 59285.40714592885, 61322.0, 61400.0, 61408.07887881685, 61700.07449888255, 61994.69002655048, 15625.531234062997, 15788.92105539488, 15809.4190580941, 15875.0, 15903.681926361409, 11011.944940275247, 11281.379524126252, 12112.757744845054, 12315.815262771066, 12402.75194496105, 18271.90864045698, 18276.725849112274, 18398.908005459885, 18465.261389544266, 18689.972051537297, 7734.613269336511, 7825.452218344775, 7846.3330616897065, 7859.6463159157975, 7897.368210543143, 744.0439035839029, 782.9138794732575, 823.8959793876235, 828.9555160497816, 890.7951171230653, 25340.74659253384, 25804.354891127496, 26926.730732692813, 31047.534286985712, 31258.0, 781.3358645151576, 1058.116472745251, 1091.879893211746, 1094.261373572835, 1210.3101232297506, 16040.919795400949, 16082.0, 16187.028778273341, 16242.593935151479, 16327.428540001281, 595670.0, 597218.0, 597662.0, 600703.0, 603174.0, 63634.36365636377, 64214.67892660507, 64239.39401514906, 64296.0, 64529.064128076236, 1230.6246594788674, 1394.4213151542199, 1431.0054512114189, 1442.2067862675488, 1447.3559266126472, 21007.68488472705, 29433.411331773674, 30587.54118688266, 30842.27044207515, 31263.53104703477, 54410.0, 54443.45556544384, 54689.72655136699, 54820.72589637026, 55083.72458137684, 541958.0, 543164.0, 545587.0, 547872.0, 549620.0, 23861.88069059713, 24397.634035489125, 26584.867075664497, 27672.861635691694, 27677.169684909484, 37615.62384376121, 47860.0, 48694.75652621714, 51099.23351149661, 51560.22659660033, 40512.59487405206, 40640.59359406486, 40880.59119408887, 41107.7944610275, 42302.153956921306, 31322.686773131976, 41034.1793164141, 41497.0, 41794.869248264615, 42191.0, 36155.55377784859, 36585.817070914476, 36702.0, 36775.26449471049, 37081.81459092687, 24473.75526244786, 25200.621990670523, 32816.835915821226, 33147.50278745773, 33207.16982075467, 23541.646875297225, 24511.509769804146, 24744.0, 24800.751992479843, 25231.864566094937], "value": 20063.622825209182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.38441070902616, 389.9044734040161, 391.24684981410786, 402.6517062740729, 427.3057327695686, 14871.033382830108, 16064.598385040379, 16193.757093643604, 21218.46953826155, 21296.680549791745, 17413.0, 21211.787882121174, 21348.4662883428, 22180.334589962287, 22235.888820555916, 5067.746612669361, 5808.215890854723, 6053.636781793084, 6126.38736126386, 6193.0, 5252.395974462928, 5815.185873977625, 6039.607425517349, 6092.756289748405, 6126.295476020248, 6029.698515074228, 6036.3661815509395, 6044.063170208625, 6119.3880611938675, 6124.387561243884, 5977.671228082454, 6036.39636036395, 6089.360617135181, 6110.144579758838, 6122.785702500413, 5956.37458066901, 5960.284765828085, 5982.940170598282, 5991.91012134814, 6045.516358691294, 13328.733425331438, 17180.570485737833, 25218.36954076163, 25973.22080337593, 26278.343041423926, 2627.7766389856884, 2634.2360715392515, 2700.6894207166233, 2706.9458610827674, 2714.6199532065525, 10074.294799364048, 10475.319104258275, 10488.58045678172, 14834.777478337834, 15101.47144849936, 1798.9622515276426, 1843.8801477903894, 1860.4232687866804, 1862.2178684952216, 1871.1860340751816, 133709.66290336972, 134275.0, 147579.0, 154099.0, 158483.0, 11896.226745261703, 11958.162928594915, 12068.250103735085, 12113.636590902288, 12200.267983920992, 13206.745359190862, 13815.792763108562, 15378.0, 15649.68700626004, 15685.686286274438, 8230.62962166704, 8543.914560854437, 8574.27118694918, 8614.310855131574, 8777.561121944005, 7398.630068496554, 8084.83830323402, 8332.541710205996, 8461.23848853606, 8633.352498562634, 3983.4423180754716, 4744.0, 4799.712017278975, 4806.0, 4884.877878053077, 1740.7998080220684, 2001.6697244954419, 2026.9493262668257, 2037.0934933954247, 2053.938381848547, 867.8847680730357, 875.282268539804, 892.2549671024767, 903.3586153830854, 911.343832440655, 17542.649147017244, 21202.04590793418, 21291.46771330729, 21295.041723122496, 21840.453988650093, 885.4377470306273, 886.6763631274538, 916.1479823763964, 918.9770255743526, 923.8568021956607, 10785.78428431427, 11123.888761112446, 11154.721131971766, 11168.497417616065, 11180.944095279634, 347761.0, 399241.0, 514247.0, 711892.0, 732901.670983294, 119137.0, 122474.0, 137584.31207844097, 158636.20681896748, 162131.0, 970.315927271272, 975.5902520941222, 1005.4570531912685, 1008.2287050406445, 1011.3224139826334, 18488.260469581066, 18681.43955681332, 18699.532511687317, 18741.90629046846, 18829.623407532046, 48551.51448485611, 52895.0, 60169.097463537204, 60611.09083363841, 61350.69324653348, 85396.14603853882, 87575.0, 87746.56126719326, 88965.0, 89982.0, 7688.6540105696495, 8240.546769927712, 8278.296344810758, 8383.203595658402, 8530.14698530142, 10518.631847885288, 12542.0, 12905.773951474595, 13299.468021279428, 13302.866971330162, 11054.170937179582, 11508.309501429942, 11532.308061516336, 11569.36368499707, 11589.478473468882, 5285.995660824431, 8357.080721120794, 10908.727281818017, 11386.259893106922, 11536.653900383002, 10676.092532134855, 11474.483648235682, 11545.0, 12066.577669781867, 12145.028397728338, 6176.845578860385, 8314.293285070837, 8593.484390936565, 8633.91366086331, 8654.134586541295, 8359.99680038375, 11199.440027998731, 11211.047060999907, 11388.772224555296, 11719.589814356457], "value": 9719.494087874536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.935877885495, 1427.2578259305162, 1432.3769160415227, 1449.6665766873616, 1457.1694134343425, 7476.887846682291, 7777.494462859924, 8023.037235531737, 8487.321014318855, 8490.278326342268, 8043.597820109, 8252.092269850327, 8299.709510167146, 8412.831743365128, 8432.578371081452, 2302.5510025545027, 2323.1288266899915, 2329.813614910803, 2334.7315058768204, 2335.6730057791924, 2074.1288658763356, 2138.550904310097, 2300.7469178390365, 2338.0647740903605, 2348.5420343033115, 2239.8432109752243, 2313.3291345509783, 2316.3051084674617, 2325.767423257678, 2334.241371554243, 2193.3748881568754, 2207.172310383606, 2213.612617791888, 2231.3640612425543, 2232.3414592695194, 1669.4908053043816, 2216.944576385587, 2227.0646328542052, 2254.9210777622707, 2258.706368172127, 7592.696292148307, 8016.8396632067615, 8419.158084191593, 8451.915480845235, 8485.151484851527, 5084.669496482754, 5244.082285600043, 5252.0, 5254.842354729364, 5279.52484276417, 3317.1209629448217, 3479.443289073761, 3498.615152333267, 3501.1947252132154, 3568.8044505090566, 1201.7536405036947, 1208.5347141350555, 1237.2143688757703, 1257.937103144839, 1264.5890085722176, 10621.893781062245, 10758.139348852152, 10782.245242833005, 10801.621943232029, 10803.135749140129, 4364.476262848479, 4664.300354946785, 4720.0, 4725.929111063337, 4735.337052812609, 9456.054394560626, 9517.714468565953, 9550.331476796697, 9551.61793528265, 9560.521973901277, 5260.447652996457, 5275.947240527622, 5280.762365693553, 5281.762320695578, 5284.524392804589, 4509.616682581952, 4647.814087436533, 4760.619150467955, 4840.685355451955, 4864.148773964613, 3432.7768695034742, 3661.139632186434, 3862.575116737157, 3873.1091848874917, 3957.2876882160913, 1172.2556176827775, 1220.725336799231, 1286.523986125121, 1288.0790234981846, 1295.1387327427344, 760.0347558600546, 763.1643350531159, 786.3316181245896, 809.6842231529708, 850.5959669157224, 4853.587445067209, 5573.219749235111, 5674.290713660793, 5708.80019199326, 5868.911966320508, 844.801471654173, 951.857221416793, 1020.806046851096, 1042.4943902207424, 1042.7288904884633, 3826.368649172911, 3841.673457756066, 3847.0, 3914.432407300925, 3929.9214015719526, 9525.809483810284, 10002.0, 10014.39913605186, 10023.14803241718, 10052.246081543914, 9962.452065136487, 9964.20286377088, 9965.850512242323, 9974.401535907724, 10002.749931251778, 7394.889076663854, 7663.846723065508, 7850.293473587404, 7854.057513098464, 7961.960190199012, 5744.224529688438, 5751.626144300607, 5885.499732522783, 5945.672987985702, 5988.0, 8822.823543528964, 9154.313426493172, 9158.587863546023, 9251.259899207913, 9305.348625596414, 9059.22996545301, 9146.63413463454, 9253.648311693429, 9368.34421590482, 9389.389689670423, 7115.964420177866, 7172.426205903411, 7183.425325973805, 7247.782566523013, 7264.055672762507, 7852.45032847718, 7898.526088434713, 7907.525548467111, 7928.088269849041, 7941.523508589503, 7021.859562808818, 7152.177499587406, 7154.499185056996, 7189.7483588074165, 7267.236940121211, 6256.593321434092, 6970.0, 6975.8256043597285, 7010.123734533184, 7029.929700703132, 6218.0, 6361.809145725636, 6420.229572451336, 6430.614163150226, 6478.060681201294, 4608.824749688808, 5031.496850315086, 5067.923981140212, 5074.898502029865, 5151.150060240018, 4344.283193273074, 4807.95192048075, 4973.303737476684, 5072.365954255718, 5213.869653258699], "value": 4405.669490905773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.99115022124425, 361.9420892657175, 364.86499995001844, 374.29819089207734, 376.8304263081614, 4812.518748125186, 5155.587552995761, 5242.8165014224505, 5438.184272359148, 5532.640378375408, 5262.421133675302, 5399.40606533282, 5457.754401051952, 5536.2249285100015, 5552.0, 3283.6387997320276, 4027.8791636250958, 4232.111256636094, 4239.6396306314, 4330.285502892019, 4167.895802604929, 4173.937390939123, 4176.102138040321, 4183.97908010461, 4184.7907604619795, 3664.59689434162, 4118.320477121287, 4153.8338466461455, 4162.854300099497, 4179.728317659343, 3826.6747326477284, 4167.83328666853, 4171.97914010428, 4176.185643799445, 4184.456020717303, 3253.1541799132397, 3255.9023229303157, 3522.7534072614926, 3575.5173051637958, 3575.8390872410805, 4929.8028078876805, 5411.756470958816, 5433.592480563973, 5443.319585051869, 5467.699276539789, 4436.911261774779, 4796.400449943757, 4801.615870730333, 4806.567408933178, 4808.519148085198, 4527.660425468071, 5294.073537131025, 5352.812651557177, 5752.0796672532615, 5804.854878628068, 3208.743300535975, 3683.526589364249, 3940.7931558327427, 3955.4462375267485, 3958.34687276599, 5178.922316165261, 5368.677879327252, 5607.859803504904, 5859.53123750099, 6170.136180934673, 3343.2811945431363, 3789.488419063391, 3891.610838916086, 3940.862069827542, 3987.980060099681, 3474.9575127461662, 3477.217626034122, 4088.2232375848494, 4115.36211887158, 4126.855560055384, 4181.519125300569, 4216.91566168681, 4579.564941330568, 4811.27830825372, 4823.5658790709, 4696.7416792076765, 4879.3163759931895, 5323.86690332737, 5530.281063461724, 5852.970735146297, 1225.3995542184266, 1302.3032677517483, 1307.7776777947772, 1314.7633425983415, 1320.3398300849576, 781.7576551269011, 794.2216627704881, 830.667732906842, 879.7668617816283, 890.3366991591306, 4525.208088584484, 4788.880277993008, 4927.90144197114, 5056.696598204119, 5250.396204436539, 5182.714950677673, 5343.812966546152, 5451.563874889999, 5675.764814056031, 5855.677937713382, 4159.521655009652, 4633.389777171668, 4698.88252793676, 5034.572061374751, 5171.301874247004, 2586.784211420629, 2959.5054497478636, 3039.7568194544383, 3066.3100802319746, 3077.215310095956, 5195.571217915103, 5781.855453613609, 5997.220361352996, 6016.067509536029, 6060.878782424415, 4847.891167342217, 5206.661566998133, 5262.736863156827, 5411.672980618372, 5929.805971790465, 4980.427250866197, 5117.0, 5459.945400545944, 5710.914926164016, 6098.597322615823, 4804.543568361, 4944.406671199479, 5551.3638566738855, 5778.508826749605, 5783.219265399117, 5358.517733404013, 5424.484673955968, 5895.322037965689, 5950.553708471795, 5959.523238141025, 5831.4168583141345, 6215.223097112861, 6241.188645476059, 6247.687615619292, 6261.279952805304, 3391.608915714366, 3457.4468085106264, 3697.0018095114706, 3857.209272099157, 3932.233214523255, 5193.467926961631, 5204.427512973494, 5762.801645087017, 5972.372900845522, 6006.399360063959, 4944.678595891256, 5686.829395117988, 5707.828765137053, 5911.408859114226, 5966.075258334965, 5014.448410674896, 5481.616286859881, 5805.187273781589, 5818.418158184148, 5875.441833025856, 5515.393306736336, 5542.3349198094875, 5585.916211256753, 5676.262085928803, 5771.480566749013, 4890.731009794496, 5005.899882002267, 5892.440218179266, 5908.881822363614, 5931.7627294907725, 4151.107511884959, 4557.726536407826, 5732.398098199796, 5806.16792916673, 5832.825015249549], "value": 4120.841196046011, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.6023666510088, 706.8020954132844, 742.8922806193101, 769.3422124083908, 849.5497386385216, 12877.806832897502, 14790.18653974031, 15392.923035384836, 15609.999999999985, 15745.134017629025, 14678.926605366985, 14786.334614942354, 14792.964492485504, 14808.851911480882, 14812.407503699866, 878.3544095090103, 883.7658020624508, 893.6425429828056, 895.7044175422095, 896.7399454158286, 730.514208051645, 879.2174964281794, 884.2572239318971, 893.1202765276198, 894.3739382432324, 909.522500687138, 937.8780758501385, 941.1717688434203, 941.7033634405141, 942.6276620734806, 914.5015966298383, 927.9953600232024, 932.8507438809758, 933.4352716606423, 935.4200395754642, 684.0662495693343, 694.2224708326706, 696.0186137546036, 696.9686364113627, 697.292248367907, 13409.865901341056, 13614.0, 13763.036587438883, 13765.931170344184, 13897.444102235899, 11907.16649834512, 11996.580119695856, 12027.398630068461, 12102.636920892388, 12461.875381246162, 10556.841647375295, 10765.192610554239, 10799.460026998619, 10881.401522916236, 11123.888761112446, 3589.569251689814, 3673.0, 3678.9264214715554, 3759.56764972029, 3801.6768574671187, 104100.47949760279, 108599.0, 108652.45673771581, 110155.0, 110473.0, 8775.341849361323, 9046.366754327133, 9134.680286189952, 9141.771455713528, 9176.0, 19387.4183774487, 19862.404127876187, 19888.303909363392, 19920.3027894023, 19920.70118948217, 7275.599842008634, 7386.168822456643, 7513.023306970059, 7626.542407455459, 7906.644201010853, 4237.322028475429, 4263.317869140985, 4279.550647182001, 4314.22343978087, 4314.41755363022, 3430.7255419566377, 3490.0, 3509.771864828829, 3517.9973707493755, 3525.1715846775987, 626.7148447456397, 630.2374127306011, 631.4443289904855, 641.746510128506, 650.2652003236312, 610.4018062298971, 610.71906922816, 635.9491240700733, 646.8647523596059, 654.4339146638124, 9382.812343753087, 9701.272404569685, 9771.609135634637, 9985.500724963722, 10161.491925403849, 567.2314014510279, 627.1408170805934, 645.6223109480912, 663.9070530125787, 686.4954258620011, 4500.122476117126, 4738.099761045391, 4744.525547445228, 4747.382840230817, 4750.738709371018, 103749.53224398154, 108846.0, 111074.88925110808, 111492.0, 112294.0, 71086.64456677684, 76472.70581882552, 77180.0, 79231.0, 100212.49893750485, 77412.0, 79351.60324198457, 80380.0, 80526.19473805305, 82412.0, 10858.67423977282, 10905.672829815117, 11212.43937803123, 11215.0, 11236.55053797839, 41805.0, 46940.765296173304, 47351.52648473471, 49954.0, 54271.0, 68957.31042689508, 69506.0, 71020.28979710137, 71634.0, 72542.0, 11937.104717146423, 12647.494100235888, 12957.740845183233, 13114.672133196746, 13177.407016684081, 14214.395572124513, 14701.41194352214, 14844.183569903758, 15118.546443606709, 15144.848551514344, 13409.798853017408, 13552.457901683822, 13617.591472255848, 13645.454181832616, 13788.793168102286, 13506.729865402833, 13607.727845442838, 13675.0, 13751.381187846371, 14047.227402492961, 11596.76806463849, 13240.933795330962, 13438.932805336302, 13463.932680336928, 13649.976251780958, 10371.429571373646, 10791.838122428328, 10992.340459572451, 11128.332300062022, 11547.826782598437, 7596.8480630388185, 7926.0, 9983.500824958577, 10944.835827462754, 11010.229283950046], "value": 7369.304811519389, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 118.0, 118.0, 117.0, 144.0, 174.0, 118.0, 117.0, 116.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 110.0, 159.0, 113.0, 118.0, 101.0, 142.0, 165.0, 144.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 211.0, 205.0, 199.0, 196.0, 196.0, 195.0, 197.0, 199.0, 189.0], "value": 199.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 60.0, 59.0, 85.0, 60.0, 61.0, 62.0, 67.0, 93.0, 53.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 85.0, 104.0, 100.0, 106.0, 92.0, 69.0, 70.0, 83.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 101.0, 89.0, 87.0, 90.0, 86.0, 90.0, 87.0, 89.0, 86.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 99.0, 99.0, 99.0, 98.0, 100.0, 110.0, 99.0, 99.0], "value": 100.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 92.0, 91.0, 92.0, 93.0, 93.0, 92.0, 93.0, 91.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 64.0, 63.0, 63.0, 65.0, 67.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 108.0, 118.0, 116.0, 79.0, 72.0, 75.0, 72.0, 72.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 82.0, 102.0, 110.0, 115.0, 95.0, 90.0, 89.0, 92.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 160.0, 141.0, 142.0, 152.0, 151.0, 128.0, 176.0, 199.0, 201.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 242.0, 190.0, 178.0, 174.0, 177.0, 178.0, 175.0, 175.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 79.0, 86.0, 68.0, 63.0, 73.0, 88.0, 89.0, 88.0], "value": 78.8, "unit": "score"}]}]} 04:37:08 INFO - Return code: 0 04:37:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:37:08 ERROR - # TBPL SUCCESS # 04:37:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:09 INFO - 2017-01-31 04:37:08.998 screenresolution[1665:10284] starting screenresolution argv=screenresolution get 04:37:09 INFO - 2017-01-31 04:37:09.001 screenresolution[1665:10284] Display 0: 1600x1200x32@60 04:37:09 INFO - 2017-01-31 04:37:09.007 screenresolution[1666:10287] starting screenresolution argv=screenresolution list 04:37:09 INFO - Available Modes on Display 0 04:37:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:09 INFO - Intel Iris: 04:37:09 INFO - Chipset Model: Intel Iris 04:37:09 INFO - Type: GPU 04:37:09 INFO - Bus: Built-In 04:37:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:09 INFO - Vendor: Intel (0x8086) 04:37:09 INFO - Device ID: 0x0a2e 04:37:09 INFO - Revision ID: 0x0009 04:37:09 INFO - Displays: 04:37:09 INFO - Display: 04:37:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:09 INFO - Display Serial Number: 1600x1200 60 04:37:09 INFO - Main Display: Yes 04:37:09 INFO - Mirror: Off 04:37:09 INFO - Online: Yes 04:37:09 INFO - Rotation: Supported 04:37:09 INFO - Return code: 0 04:37:09 INFO - Running post-action listener: _resource_record_post_action 04:37:09 INFO - [mozharness: 2017-01-31 12:37:09.242995Z] Finished run-tests step (success) 04:37:09 INFO - Running post-run listener: _resource_record_post_run 04:37:09 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39094272; Write bytes: 556753920; Read time: 249; Write time: 1730 04:37:09 INFO - TinderboxPrint: CPU usage
54.4% 04:37:09 INFO - TinderboxPrint: I/O read bytes / time
39,094,272 / 249 04:37:09 INFO - TinderboxPrint: I/O write bytes / time
556,753,920 / 1,730 04:37:09 INFO - TinderboxPrint: CPU idle
2,191.3 (45.6%) 04:37:09 INFO - TinderboxPrint: CPU system
965.5 (20.1%) 04:37:09 INFO - TinderboxPrint: CPU user
1,645.0 (34.3%) 04:37:09 INFO - TinderboxPrint: Swap in / out
291,368,960 / 0 04:37:09 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250798592; Write bytes: 244779008; Read time: 18127; Write time: 517 04:37:09 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35670016; Write bytes: 300686336; Read time: 226; Write time: 1176 04:37:09 INFO - Running post-run listener: _upload_blobber_files 04:37:09 INFO - Blob upload gear active. 04:37:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:09 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 04:37:09 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'] 04:37:09 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 04:37:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:37:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:11 INFO - (blobuploader) - INFO - Done attempting. 04:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:37:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:12 INFO - (blobuploader) - INFO - Done attempting. 04:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:37:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:37:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:13 INFO - (blobuploader) - INFO - Done attempting. 04:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:16 INFO - (blobuploader) - INFO - Done attempting. 04:37:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:16 INFO - Return code: 0 04:37:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0abfe01e0a2e0332e0e15b14a16e38c49b5011cb80e8c624dbc28f3831c2f27ddf5ee6e1b959b753541751dc487c1f964f06aa10d4e139b011d90d9ba15e2c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd4e135d1b7744f7e401bf41e6df5a3e7deffecbf655fe90fc3e89dc44b98f938b11a9925789e26fbea7811286bf054c67cb4cacc365c606cce2845cd528d4c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07a0779a70ad42eb5811feea02c65ebb0b868cac3371921ce6eb7ffaf937c2d4307c3fec3ccb9f9686536ff9f18147f33a09c4f0e6a918d657c419f0e9b5098d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cecd607378e44d4d0a63e26328a53cebbef0fb22d458fdc28c395e2b8fa1687e161cd448317df9d01a533d6d73628e0ab689118af4f3f8141d88ee735d0f3c"} 04:37:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:16 INFO - Contents: 04:37:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0abfe01e0a2e0332e0e15b14a16e38c49b5011cb80e8c624dbc28f3831c2f27ddf5ee6e1b959b753541751dc487c1f964f06aa10d4e139b011d90d9ba15e2c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd4e135d1b7744f7e401bf41e6df5a3e7deffecbf655fe90fc3e89dc44b98f938b11a9925789e26fbea7811286bf054c67cb4cacc365c606cce2845cd528d4c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07a0779a70ad42eb5811feea02c65ebb0b868cac3371921ce6eb7ffaf937c2d4307c3fec3ccb9f9686536ff9f18147f33a09c4f0e6a918d657c419f0e9b5098d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cecd607378e44d4d0a63e26328a53cebbef0fb22d458fdc28c395e2b8fa1687e161cd448317df9d01a533d6d73628e0ab689118af4f3f8141d88ee735d0f3c"} 04:37:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:16 INFO - Copying logs to upload dir... 04:37:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.962590 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-31 04:37:16.216288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 04:37:16.220578) ========= 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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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/b0abfe01e0a2e0332e0e15b14a16e38c49b5011cb80e8c624dbc28f3831c2f27ddf5ee6e1b959b753541751dc487c1f964f06aa10d4e139b011d90d9ba15e2c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd4e135d1b7744f7e401bf41e6df5a3e7deffecbf655fe90fc3e89dc44b98f938b11a9925789e26fbea7811286bf054c67cb4cacc365c606cce2845cd528d4c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07a0779a70ad42eb5811feea02c65ebb0b868cac3371921ce6eb7ffaf937c2d4307c3fec3ccb9f9686536ff9f18147f33a09c4f0e6a918d657c419f0e9b5098d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cecd607378e44d4d0a63e26328a53cebbef0fb22d458fdc28c395e2b8fa1687e161cd448317df9d01a533d6d73628e0ab689118af4f3f8141d88ee735d0f3c"} build_url:https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010780 build_url: 'https://queue.taskcluster.net/v1/task/MK2Y2I8JQJeKCp-n2WxT1Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0abfe01e0a2e0332e0e15b14a16e38c49b5011cb80e8c624dbc28f3831c2f27ddf5ee6e1b959b753541751dc487c1f964f06aa10d4e139b011d90d9ba15e2c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd4e135d1b7744f7e401bf41e6df5a3e7deffecbf655fe90fc3e89dc44b98f938b11a9925789e26fbea7811286bf054c67cb4cacc365c606cce2845cd528d4c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07a0779a70ad42eb5811feea02c65ebb0b868cac3371921ce6eb7ffaf937c2d4307c3fec3ccb9f9686536ff9f18147f33a09c4f0e6a918d657c419f0e9b5098d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cecd607378e44d4d0a63e26328a53cebbef0fb22d458fdc28c395e2b8fa1687e161cd448317df9d01a533d6d73628e0ab689118af4f3f8141d88ee735d0f3c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 04:37:16.256978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 04:37:16.257296) ========= 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.1gCWLbKOkS/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.GnWmfGiCwZ/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.004990 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 04:37:16.304714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 04:37:16.304995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 04:37:16.308302) ========= ========= Total master_lag: 0.20 =========