builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0182 starttime: 1493077339.76 results: success (0) buildid: 20170424154625 builduid: 99bc8e20d7f145cfbae10fbf12ced28d revision: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:19.755981) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:19.756413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:19.756703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:19.789381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:19.789773) ========= 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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-24 16:42:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.0M=0.001s 2017-04-24 16:42:19 (15.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.186958 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:20.012169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:20.012535) ========= 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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.029856 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:20.068165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 16:42:20.068563) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b --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 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xDkCUyNMw8/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.RLu1aDsg7L/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-24 16:42:20,182 truncating revision to first 12 chars 2017-04-24 16:42:20,182 Setting DEBUG logging. 2017-04-24 16:42:20,182 attempt 1/10 2017-04-24 16:42:20,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/196e7e9e2e44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 16:42:21,101 unpacking tar archive at: mozilla-central-196e7e9e2e44/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499362 ========= master_lag: 0.98 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 16:42:22.549256) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:22.549717) ========= script_repo_revision: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:22.550202) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:22.550469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 16:42:22.572839) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-24 16:42:22.573491) ========= /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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:42:22 INFO - MultiFileLogger online at 20170424 16:42:22 in /builds/slave/test 16:42:22 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 16:42:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:22 INFO - {'append_to_log': False, 16:42:22 INFO - 'base_work_dir': '/builds/slave/test', 16:42:22 INFO - 'blob_upload_branch': 'Firefox', 16:42:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:22 INFO - 'branch': 'Firefox', 16:42:22 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:22 INFO - 'config_files': ('talos/mac_config.py',), 16:42:22 INFO - 'default_actions': ('clobber', 16:42:22 INFO - 'read-buildbot-config', 16:42:22 INFO - 'download-and-extract', 16:42:22 INFO - 'populate-webroot', 16:42:22 INFO - 'create-virtualenv', 16:42:22 INFO - 'install', 16:42:22 INFO - 'run-tests'), 16:42:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:22 INFO - 'download_minidump_stackwalk': True, 16:42:22 INFO - 'download_symbols': 'ondemand', 16:42:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:22 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:22 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:22 INFO - 'gecko_profile': False, 16:42:22 INFO - 'gecko_profile_interval': 0, 16:42:22 INFO - 'installer_path': 'installer.exe', 16:42:22 INFO - 'log_level': 'info', 16:42:22 INFO - 'log_name': 'talos', 16:42:22 INFO - 'log_to_console': True, 16:42:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:42:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:42:22 INFO - 'opt_config_files': (), 16:42:22 INFO - 'pip_index': False, 16:42:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:42:22 INFO - 'cmd': ('bash', 16:42:22 INFO - '-c', 16:42:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:42:22 INFO - 'enabled': True, 16:42:22 INFO - 'halt_on_failure': False, 16:42:22 INFO - 'name': 'check_screen_resolution'},), 16:42:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:42:22 INFO - 'cmd': ('bash', 16:42:22 INFO - '-c', 16:42:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:42:22 INFO - 'enabled': True, 16:42:22 INFO - 'halt_on_failure': False, 16:42:22 INFO - 'name': 'check_screen_resolution'},), 16:42:22 INFO - 'run_cmd_checks_enabled': True, 16:42:22 INFO - 'suite': 'dromaeojs-e10s', 16:42:22 INFO - 'system_bits': '32', 16:42:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:22 INFO - 'title': 't-yosemite-r7-0182', 16:42:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:22 INFO - 'use_talos_json': True, 16:42:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:22 INFO - 'work_dir': 'build'} 16:42:22 INFO - [mozharness: 2017-04-24 23:42:22.794046Z] Running clobber step. 16:42:22 INFO - Running pre-action listener: _resource_record_pre_action 16:42:22 INFO - Running main action method: clobber 16:42:22 INFO - rmtree: /builds/slave/test/build 16:42:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:25 INFO - Running post-action listener: _resource_record_post_action 16:42:25 INFO - [mozharness: 2017-04-24 23:42:25.376979Z] Finished clobber step (success) 16:42:25 INFO - [mozharness: 2017-04-24 23:42:25.377116Z] Running read-buildbot-config step. 16:42:25 INFO - Running pre-action listener: _resource_record_pre_action 16:42:25 INFO - Running main action method: read_buildbot_config 16:42:25 INFO - Using buildbot properties: 16:42:25 INFO - { 16:42:25 INFO - "project": "", 16:42:25 INFO - "product": "firefox", 16:42:25 INFO - "script_repo_revision": "production", 16:42:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:42:25 INFO - "repository": "", 16:42:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:42:25 INFO - "buildid": "20170424154625", 16:42:25 INFO - "pgo_build": "False", 16:42:25 INFO - "basedir": "/builds/slave/test", 16:42:25 INFO - "buildnumber": 128, 16:42:25 INFO - "slavename": "t-yosemite-r7-0182", 16:42:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:42:25 INFO - "platform": "yosemite_r7", 16:42:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:42:25 INFO - "branch": "mozilla-central", 16:42:25 INFO - "repo_path": "mozilla-central", 16:42:25 INFO - "revision": "196e7e9e2e44fa88b597a2405d0e599e5ee11e5b", 16:42:25 INFO - "stage_platform": "macosx64", 16:42:25 INFO - "builduid": "99bc8e20d7f145cfbae10fbf12ced28d", 16:42:25 INFO - "slavebuilddir": "test" 16:42:25 INFO - } 16:42:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:42:25 INFO - Running post-action listener: _resource_record_post_action 16:42:25 INFO - [mozharness: 2017-04-24 23:42:25.380656Z] Finished read-buildbot-config step (success) 16:42:25 INFO - [mozharness: 2017-04-24 23:42:25.380760Z] Running download-and-extract step. 16:42:25 INFO - Running pre-action listener: _resource_record_pre_action 16:42:25 INFO - Running main action method: download_and_extract 16:42:25 INFO - mkdir: /builds/slave/test/build/tests 16:42:25 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')]} 16:42:25 INFO - trying https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:42:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:42:26 INFO - Downloaded 1325 bytes. 16:42:26 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:42:26 INFO - Using the following test package requirements: 16:42:26 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:42:26 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:42:26 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:42:26 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:42:26 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'jsshell-mac.zip'], 16:42:26 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:42:26 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:42:26 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:42:26 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:42:26 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:42:26 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:42:26 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:42:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:42:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:42:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:42:26 INFO - Fetch https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:42:27 INFO - Content-Length response header: 52523299 16:42:27 INFO - Bytes received: 52523299 16:42:44 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:42:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:42:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:42:44 INFO - Fetch https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:42:46 INFO - Content-Length response header: 52523299 16:42:46 INFO - Bytes received: 52523299 16:43:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:43:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:43:01 INFO - Fetch https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:43:02 INFO - Content-Length response header: 14408822 16:43:02 INFO - Bytes received: 14408822 16:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:03 INFO - trying https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:43:03 INFO - Downloading https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:43:05 INFO - Downloaded 71041574 bytes. 16:43:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:43:05 INFO - mkdir: /builds/slave/test/properties 16:43:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:05 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:05 INFO - Contents: 16:43:05 INFO - build_url:https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:43:05 INFO - Running post-action listener: _resource_record_post_action 16:43:05 INFO - Running post-action listener: set_extra_try_arguments 16:43:05 INFO - [mozharness: 2017-04-24 23:43:05.760554Z] Finished download-and-extract step (success) 16:43:05 INFO - [mozharness: 2017-04-24 23:43:05.760688Z] Running populate-webroot step. 16:43:05 INFO - Running pre-action listener: _resource_record_pre_action 16:43:05 INFO - Running main action method: populate_webroot 16:43:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:05 INFO - '--tppagecycles', 16:43:05 INFO - '7'], 16:43:05 INFO - 'tests': ['tsvgm']}}, 16:43:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:43:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:43:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:43:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:43:05 INFO - 'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:43:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:43:05 INFO - 'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['damp', 'tps']}, 16:43:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:43:05 INFO - 'tests': ['damp', 'tps']}, 16:43:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['dromaeo_dom']}, 16:43:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:43:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:43:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['a11yr', 16:43:05 INFO - 'ts_paint', 16:43:05 INFO - 'tpaint', 16:43:05 INFO - 'sessionrestore', 16:43:05 INFO - 'sessionrestore_no_auto_restore', 16:43:05 INFO - 'tabpaint']}, 16:43:05 INFO - 'other-e10s': {'tests': ['a11yr', 16:43:05 INFO - 'ts_paint', 16:43:05 INFO - 'tpaint', 16:43:05 INFO - 'sessionrestore', 16:43:05 INFO - 'sessionrestore_no_auto_restore', 16:43:05 INFO - 'tabpaint']}, 16:43:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:43:05 INFO - 'ts_paint', 16:43:05 INFO - 'tpaint', 16:43:05 INFO - 'sessionrestore', 16:43:05 INFO - 'sessionrestore_no_auto_restore', 16:43:05 INFO - 'tabpaint']}, 16:43:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:43:05 INFO - 'ts_paint', 16:43:05 INFO - 'tpaint', 16:43:05 INFO - 'sessionrestore', 16:43:05 INFO - 'sessionrestore_no_auto_restore', 16:43:05 INFO - 'tabpaint']}, 16:43:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['a11yr', 16:43:05 INFO - 'ts_paint', 16:43:05 INFO - 'tpaint', 16:43:05 INFO - 'sessionrestore', 16:43:05 INFO - 'sessionrestore_no_auto_restore', 16:43:05 INFO - 'tabpaint']}, 16:43:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['a11yr', 16:43:05 INFO - 'ts_paint', 16:43:05 INFO - 'tpaint', 16:43:05 INFO - 'sessionrestore', 16:43:05 INFO - 'sessionrestore_no_auto_restore', 16:43:05 INFO - 'tabpaint']}, 16:43:05 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:43:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:43:05 INFO - 'bloom_basic_ref']}, 16:43:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['tsvgx', 16:43:05 INFO - 'tsvgr_opacity', 16:43:05 INFO - 'tart', 16:43:05 INFO - 'tscrollx', 16:43:05 INFO - 'cart', 16:43:05 INFO - 'tsvg_static']}, 16:43:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:43:05 INFO - 'tsvgr_opacity', 16:43:05 INFO - 'tart', 16:43:05 INFO - 'tscrollx', 16:43:05 INFO - 'cart', 16:43:05 INFO - 'tsvg_static']}, 16:43:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:43:05 INFO - 'talos_options': ['--disable-e10s'], 16:43:05 INFO - 'tests': ['tp5o']}, 16:43:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:43:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:43:05 INFO - 'talos_options': ['--disable-e10s', 16:43:05 INFO - '--xperf_path', 16:43:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:05 INFO - 'tests': ['tp5n']}, 16:43:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:43:05 INFO - 'talos_options': ['--xperf_path', 16:43:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:05 INFO - 'tests': ['tp5n']}}, 16:43:05 INFO - 'talos.zip': {'path': '', 16:43:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:05 INFO - Running post-action listener: _resource_record_post_action 16:43:05 INFO - [mozharness: 2017-04-24 23:43:05.779712Z] Finished populate-webroot step (success) 16:43:05 INFO - [mozharness: 2017-04-24 23:43:05.779840Z] Running create-virtualenv step. 16:43:05 INFO - Running pre-action listener: _resource_record_pre_action 16:43:05 INFO - Running main action method: create_virtualenv 16:43:05 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:05 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 16:43:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:05 INFO - Using real prefix '/tools/python27' 16:43:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:06 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:09 INFO - Installing pip.................done. 16:43:09 INFO - Return code: 0 16:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:43:09 INFO - Reading from file tmpfile_stdout 16:43:09 INFO - Output received: 16:43:09 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) 16:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43:09 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')]} 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:10 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')]} 16:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:10 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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:10 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 16:43:10 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 16:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:10 INFO - 'HOME': '/Users/cltbld', 16:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:10 INFO - 'LOGNAME': 'cltbld', 16:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:10 INFO - 'MOZ_NO_REMOTE': '1', 16:43:10 INFO - 'NO_EM_RESTART': '1', 16:43:10 INFO - 'PAGER': '/bin/cat', 16:43:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:10 INFO - 'PWD': '/builds/slave/test', 16:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:10 INFO - 'SHELL': '/bin/bash', 16:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:10 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:10 INFO - 'USER': 'cltbld', 16:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:10 INFO - 'XPC_FLAGS': '0x0', 16:43:10 INFO - 'XPC_SERVICE_NAME': '0', 16:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:10 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 16:43:10 INFO - Cleaning up... 16:43:10 INFO - Return code: 0 16:43:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:43:10 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')]} 16:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:11 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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:11 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 16:43:11 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 16:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:11 INFO - 'HOME': '/Users/cltbld', 16:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:11 INFO - 'LOGNAME': 'cltbld', 16:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:11 INFO - 'MOZ_NO_REMOTE': '1', 16:43:11 INFO - 'NO_EM_RESTART': '1', 16:43:11 INFO - 'PAGER': '/bin/cat', 16:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:11 INFO - 'PWD': '/builds/slave/test', 16:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:11 INFO - 'SHELL': '/bin/bash', 16:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:11 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:11 INFO - 'USER': 'cltbld', 16:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:11 INFO - 'XPC_FLAGS': '0x0', 16:43:11 INFO - 'XPC_SERVICE_NAME': '0', 16:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:11 INFO - Downloading/unpacking psutil>=3.1.1 16:43:11 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 16:43:11 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 16:43:11 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 16:43:11 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 16:43:11 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 16:43:11 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 16:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:43:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:15 INFO - Installing collected packages: psutil 16:43:15 INFO - Running setup.py install for psutil 16:43:15 INFO - building 'psutil._psutil_osx' extension 16:43:15 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 16:43:16 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 16:43:16 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 16:43:16 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 16:43:16 INFO - building 'psutil._psutil_posix' extension 16:43:16 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 16:43:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:43:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:43:16 INFO - ^ 16:43:16 INFO - 1 warning generated. 16:43:16 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 16:43:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:16 INFO - Successfully installed psutil 16:43:16 INFO - Cleaning up... 16:43:16 INFO - Return code: 0 16:43:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:43:16 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')]} 16:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:16 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')]} 16:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:16 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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:16 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 16:43:16 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 16:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:16 INFO - 'HOME': '/Users/cltbld', 16:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:16 INFO - 'LOGNAME': 'cltbld', 16:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:16 INFO - 'MOZ_NO_REMOTE': '1', 16:43:16 INFO - 'NO_EM_RESTART': '1', 16:43:16 INFO - 'PAGER': '/bin/cat', 16:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:16 INFO - 'PWD': '/builds/slave/test', 16:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:16 INFO - 'SHELL': '/bin/bash', 16:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:16 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:16 INFO - 'USER': 'cltbld', 16:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:16 INFO - 'XPC_FLAGS': '0x0', 16:43:16 INFO - 'XPC_SERVICE_NAME': '0', 16:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:43:17 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 16:43:17 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 16:43:17 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 16:43:17 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 16:43:17 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 16:43:17 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 16:43:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:43:19 INFO - Installing collected packages: mozsystemmonitor 16:43:19 INFO - Running setup.py install for mozsystemmonitor 16:43:19 INFO - Successfully installed mozsystemmonitor 16:43:19 INFO - Cleaning up... 16:43:20 INFO - Return code: 0 16:43:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:43:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:20 INFO - 'HOME': '/Users/cltbld', 16:43:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:20 INFO - 'LOGNAME': 'cltbld', 16:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:20 INFO - 'MOZ_NO_REMOTE': '1', 16:43:20 INFO - 'NO_EM_RESTART': '1', 16:43:20 INFO - 'PAGER': '/bin/cat', 16:43:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:20 INFO - 'PWD': '/builds/slave/test', 16:43:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:20 INFO - 'SHELL': '/bin/bash', 16:43:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:20 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:20 INFO - 'USER': 'cltbld', 16:43:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:20 INFO - 'XPC_FLAGS': '0x0', 16:43:20 INFO - 'XPC_SERVICE_NAME': '0', 16:43:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:20 INFO - Downloading/unpacking jsonschema==2.5.1 16:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:43:22 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 16:43:22 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 16:43:22 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 16:43:22 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 16:43:22 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 16:43:22 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 16:43:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:23 INFO - warning: no files found matching '*.txt' 16:43:23 INFO - no previously-included directories found matching 'build' 16:43:23 INFO - no previously-included directories found matching 'dist' 16:43:23 INFO - no previously-included directories found matching '.git*' 16:43:23 INFO - Installing collected packages: jsonschema, functools32 16:43:23 INFO - Running setup.py install for functools32 16:43:23 INFO - warning: no files found matching '*.txt' 16:43:23 INFO - no previously-included directories found matching 'build' 16:43:23 INFO - no previously-included directories found matching 'dist' 16:43:23 INFO - no previously-included directories found matching '.git*' 16:43:23 INFO - Successfully installed jsonschema functools32 16:43:23 INFO - Cleaning up... 16:43:23 INFO - Return code: 0 16:43:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:23 INFO - 'HOME': '/Users/cltbld', 16:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:23 INFO - 'LOGNAME': 'cltbld', 16:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:23 INFO - 'MOZ_NO_REMOTE': '1', 16:43:23 INFO - 'NO_EM_RESTART': '1', 16:43:23 INFO - 'PAGER': '/bin/cat', 16:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:23 INFO - 'PWD': '/builds/slave/test', 16:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:23 INFO - 'SHELL': '/bin/bash', 16:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:23 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:23 INFO - 'USER': 'cltbld', 16:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:23 INFO - 'XPC_FLAGS': '0x0', 16:43:23 INFO - 'XPC_SERVICE_NAME': '0', 16:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:43:24 INFO - Cleaning up... 16:43:24 INFO - Return code: 0 16:43:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:43:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:24 INFO - 'HOME': '/Users/cltbld', 16:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:24 INFO - 'LOGNAME': 'cltbld', 16:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:24 INFO - 'MOZ_NO_REMOTE': '1', 16:43:24 INFO - 'NO_EM_RESTART': '1', 16:43:24 INFO - 'PAGER': '/bin/cat', 16:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:24 INFO - 'PWD': '/builds/slave/test', 16:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:24 INFO - 'SHELL': '/bin/bash', 16:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:24 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:24 INFO - 'USER': 'cltbld', 16:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:24 INFO - 'XPC_FLAGS': '0x0', 16:43:24 INFO - 'XPC_SERVICE_NAME': '0', 16:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:24 INFO - Downloading/unpacking blobuploader==1.2.4 16:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:26 INFO - Downloading blobuploader-1.2.4.tar.gz 16:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:43:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:43:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:28 INFO - Downloading docopt-0.6.1.tar.gz 16:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:43:28 INFO - Installing collected packages: blobuploader, requests, docopt 16:43:28 INFO - Running setup.py install for blobuploader 16:43:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:43:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:43:28 INFO - Running setup.py install for requests 16:43:28 INFO - Running setup.py install for docopt 16:43:29 INFO - Successfully installed blobuploader requests docopt 16:43:29 INFO - Cleaning up... 16:43:29 INFO - Return code: 0 16:43:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:29 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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:29 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 16:43:29 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 16:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:29 INFO - 'HOME': '/Users/cltbld', 16:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:29 INFO - 'LOGNAME': 'cltbld', 16:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:29 INFO - 'MOZ_NO_REMOTE': '1', 16:43:29 INFO - 'NO_EM_RESTART': '1', 16:43:29 INFO - 'PAGER': '/bin/cat', 16:43:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:29 INFO - 'PWD': '/builds/slave/test', 16:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:29 INFO - 'SHELL': '/bin/bash', 16:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:29 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:29 INFO - 'USER': 'cltbld', 16:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:29 INFO - 'XPC_FLAGS': '0x0', 16:43:29 INFO - 'XPC_SERVICE_NAME': '0', 16:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:29 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ENetkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:29 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-2s8LAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:29 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-xJSr8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:29 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-w_0cXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:29 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-sTVYS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:29 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-vLDRoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-wr_NPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-4OhD4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-fntipx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-Xy8l1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-22GSW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ZvHzDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-xqSko9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-YOXnqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-PhwzlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ybIyY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-m0xC1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:43:31 INFO - Running setup.py install for manifestparser 16:43:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:43:31 INFO - Running setup.py install for mozcrash 16:43:31 INFO - Running setup.py install for mozdebug 16:43:31 INFO - Running setup.py install for mozdevice 16:43:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:43:31 INFO - Running setup.py install for mozfile 16:43:31 INFO - Running setup.py install for mozhttpd 16:43:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Running setup.py install for mozinfo 16:43:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Running setup.py install for mozInstall 16:43:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Running setup.py install for mozleak 16:43:32 INFO - Running setup.py install for mozlog 16:43:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Running setup.py install for moznetwork 16:43:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:43:32 INFO - Running setup.py install for mozprocess 16:43:32 INFO - Running setup.py install for mozprofile 16:43:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:43:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:43:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:43:33 INFO - Running setup.py install for mozrunner 16:43:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:43:33 INFO - Running setup.py install for mozscreenshot 16:43:33 INFO - Running setup.py install for moztest 16:43:33 INFO - Running setup.py install for mozversion 16:43:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:43:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:43:33 INFO - Cleaning up... 16:43:33 INFO - Return code: 0 16:43:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:33 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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:33 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 16:43:33 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 16:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:33 INFO - 'HOME': '/Users/cltbld', 16:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:33 INFO - 'LOGNAME': 'cltbld', 16:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:33 INFO - 'MOZ_NO_REMOTE': '1', 16:43:33 INFO - 'NO_EM_RESTART': '1', 16:43:33 INFO - 'PAGER': '/bin/cat', 16:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:33 INFO - 'PWD': '/builds/slave/test', 16:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:33 INFO - 'SHELL': '/bin/bash', 16:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:33 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:33 INFO - 'USER': 'cltbld', 16:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:33 INFO - 'XPC_FLAGS': '0x0', 16:43:33 INFO - 'XPC_SERVICE_NAME': '0', 16:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-fFeZFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-pJ3ZNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-4KFNtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-dX0xIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-fuUXTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-l2lVaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-3vq61j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-SHjLpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-1k1zEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:34 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)) 16:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:34 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ATx8EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:35 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)) 16:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:35 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-15845d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:35 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)) 16:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:35 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-NwJv0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:35 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-qvAjsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:35 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)) 16:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:35 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-UNL8KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:35 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)) 16:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:35 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-FiKPCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:35 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)) 16:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:35 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-MI5kRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:35 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)) 16:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:35 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ULbmDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:35 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)) 16:43:35 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)) 16:43:35 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)) 16:43:35 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)) 16:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:38 INFO - Downloading blessings-1.6.tar.gz 16:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:43:38 INFO - Installing collected packages: blessings 16:43:38 INFO - Running setup.py install for blessings 16:43:38 INFO - Successfully installed blessings 16:43:38 INFO - Cleaning up... 16:43:38 INFO - Return code: 0 16:43:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:39 INFO - Reading from file tmpfile_stdout 16:43:39 INFO - Current package versions: 16:43:39 INFO - blessings == 1.6 16:43:39 INFO - blobuploader == 1.2.4 16:43:39 INFO - docopt == 0.6.1 16:43:39 INFO - functools32 == 3.2.3-2 16:43:39 INFO - jsonschema == 2.5.1 16:43:39 INFO - manifestparser == 1.1 16:43:39 INFO - mozInstall == 1.12 16:43:39 INFO - mozcrash == 1.0 16:43:39 INFO - mozdebug == 0.1 16:43:39 INFO - mozdevice == 0.50 16:43:39 INFO - mozfile == 1.2 16:43:39 INFO - mozhttpd == 0.7 16:43:39 INFO - mozinfo == 0.9 16:43:39 INFO - mozleak == 0.1 16:43:39 INFO - mozlog == 3.4 16:43:39 INFO - moznetwork == 0.27 16:43:39 INFO - mozprocess == 0.25 16:43:39 INFO - mozprofile == 0.28 16:43:39 INFO - mozrunner == 6.13 16:43:39 INFO - mozscreenshot == 0.1 16:43:39 INFO - mozsystemmonitor == 0.3 16:43:39 INFO - moztest == 0.8 16:43:39 INFO - mozversion == 1.4 16:43:39 INFO - psutil == 3.1.1 16:43:39 INFO - requests == 1.2.3 16:43:39 INFO - wsgiref == 0.1.2 16:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:39 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 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43:39 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 16:43:39 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 16:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:39 INFO - 'HOME': '/Users/cltbld', 16:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:39 INFO - 'LOGNAME': 'cltbld', 16:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:39 INFO - 'MOZ_NO_REMOTE': '1', 16:43:39 INFO - 'NO_EM_RESTART': '1', 16:43:39 INFO - 'PAGER': '/bin/cat', 16:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:39 INFO - 'PWD': '/builds/slave/test', 16:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:39 INFO - 'SHELL': '/bin/bash', 16:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:39 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:39 INFO - 'USER': 'cltbld', 16:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:39 INFO - 'XPC_FLAGS': '0x0', 16:43:39 INFO - 'XPC_SERVICE_NAME': '0', 16:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 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)) 16:43:39 INFO - Cleaning up... 16:43:39 INFO - Return code: 0 16:43:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1025c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9e04c3220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, '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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 16:43: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', 'jsonschema'] in /builds/slave/test/build 16:43: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 jsonschema 16:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:39 INFO - 'HOME': '/Users/cltbld', 16:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:39 INFO - 'LOGNAME': 'cltbld', 16:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:39 INFO - 'MOZ_NO_REMOTE': '1', 16:43:39 INFO - 'NO_EM_RESTART': '1', 16:43:39 INFO - 'PAGER': '/bin/cat', 16:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:39 INFO - 'PWD': '/builds/slave/test', 16:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:39 INFO - 'SHELL': '/bin/bash', 16:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:43:39 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:39 INFO - 'USER': 'cltbld', 16:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:39 INFO - 'XPC_FLAGS': '0x0', 16:43:39 INFO - 'XPC_SERVICE_NAME': '0', 16:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:43:39 INFO - Cleaning up... 16:43:39 INFO - Return code: 0 16:43:39 INFO - Running post-action listener: _resource_record_post_action 16:43:39 INFO - Running post-action listener: _start_resource_monitoring 16:43:39 INFO - Starting resource monitoring. 16:43:39 INFO - [mozharness: 2017-04-24 23:43:39.617161Z] Finished create-virtualenv step (success) 16:43:39 INFO - [mozharness: 2017-04-24 23:43:39.618135Z] Running install step. 16:43:39 INFO - Running pre-action listener: _resource_record_pre_action 16:43:39 INFO - Running main action method: install 16:43:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:39 INFO - Reading from file tmpfile_stdout 16:43:39 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:39 INFO - Reading from file tmpfile_stdout 16:43:39 INFO - Output received: 16:43:39 INFO - Usage: mozinstall [options] installer 16:43:39 INFO - Options: 16:43:39 INFO - -h, --help show this help message and exit 16:43:39 INFO - -d DEST, --destination=DEST 16:43:39 INFO - Directory to install application into. [default: 16:43:39 INFO - "/builds/slave/test"] 16:43:39 INFO - --app=APP Application being installed. [default: firefox] 16:43:39 INFO - mkdir: /builds/slave/test/build/application 16:43:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:43:59 INFO - Reading from file tmpfile_stdout 16:43:59 INFO - Output received: 16:43:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:43:59 INFO - Running post-action listener: _resource_record_post_action 16:43:59 INFO - [mozharness: 2017-04-24 23:43:59.699995Z] Finished install step (success) 16:43:59 INFO - [mozharness: 2017-04-24 23:43:59.700108Z] Running run-tests step. 16:43:59 INFO - Running pre-action listener: _resource_record_pre_action 16:43:59 INFO - Running main action method: run_tests 16:43:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:43:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:43:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:43:59 INFO - 2017-04-24 16:43:59.714 screenresolution[1621:7404] starting screenresolution argv=screenresolution get 16:43:59 INFO - 2017-04-24 16:43:59.717 screenresolution[1621:7404] Display 0: 1600x1200x32@60 16:43:59 INFO - 2017-04-24 16:43:59.723 screenresolution[1622:7407] starting screenresolution argv=screenresolution list 16:43:59 INFO - Available Modes on Display 0 16:43:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:43:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:43:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:43:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:43:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:43:59 INFO - Intel Iris: 16:43:59 INFO - Chipset Model: Intel Iris 16:43:59 INFO - Type: GPU 16:43:59 INFO - Bus: Built-In 16:43:59 INFO - VRAM (Dynamic, Max): 1536 MB 16:43:59 INFO - Vendor: Intel (0x8086) 16:43:59 INFO - Device ID: 0x0a2e 16:43:59 INFO - Revision ID: 0x0009 16:43:59 INFO - Displays: 16:43:59 INFO - Display: 16:43:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:43:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:43:59 INFO - Display Serial Number: 1600x1200 60 16:43:59 INFO - Main Display: Yes 16:43:59 INFO - Mirror: Off 16:43:59 INFO - Online: Yes 16:43:59 INFO - Rotation: Supported 16:43:59 INFO - Return code: 0 16:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:59 INFO - Python 2.7.3 16:43:59 INFO - Return code: 0 16:43:59 INFO - grabbing minidump binary from tooltool 16:43:59 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')]} 16:43:59 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 0x1023a0d30>, '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 0x1022c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:59 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 16:43:59 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 16:43:59 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 16:44:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:00 INFO - Return code: 0 16:44:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:44:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:00 INFO - ENV: RUST_BACKTRACE is now 1 16:44:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:44:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 16:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 16:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDkCUyNMw8/Render', 16:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:00 INFO - 'HOME': '/Users/cltbld', 16:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:00 INFO - 'LOGNAME': 'cltbld', 16:44:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:00 INFO - 'MOZ_NO_REMOTE': '1', 16:44:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:00 INFO - 'NO_EM_RESTART': '1', 16:44:00 INFO - 'PAGER': '/bin/cat', 16:44:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:00 INFO - 'PWD': '/builds/slave/test', 16:44:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:00 INFO - 'RUST_BACKTRACE': '1', 16:44:00 INFO - 'SHELL': '/bin/bash', 16:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLu1aDsg7L/Listeners', 16:44:00 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 16:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:00 INFO - 'USER': 'cltbld', 16:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:00 INFO - 'XPC_FLAGS': '0x0', 16:44:00 INFO - 'XPC_SERVICE_NAME': '0', 16:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 16:44:00 INFO - mozversion application_buildid: 20170424154625 16:44:00 INFO - mozversion application_changeset: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b 16:44:00 INFO - mozversion application_display_name: Nightly 16:44:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:00 INFO - mozversion application_name: Firefox 16:44:00 INFO - mozversion application_remotingname: firefox 16:44:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:44:00 INFO - mozversion application_vendor: Mozilla 16:44:00 INFO - mozversion application_version: 55.0a1 16:44:00 INFO - mozversion platform_buildid: 20170424154625 16:44:00 INFO - mozversion platform_changeset: 196e7e9e2e44fa88b597a2405d0e599e5ee11e5b 16:44:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:44:00 INFO - mozversion platform_version: 55.0a1 16:44:00 INFO - using testdate: 1493077440 16:44:00 INFO - actual date: 1493077440 16:44:00 INFO - starting webserver on 'localhost:49242' 16:44:00 INFO - SUITE-START | Running 2 tests 16:44:00 INFO - TEST-START | dromaeo_css 16:44:00 INFO - operating with platform_type : mac_ 16:44:00 INFO - Initialising browser for dromaeo_css test... 16:44:00 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpC8Om0R/profile http://localhost:49242/getInfo.html) 16:44:03 INFO - PID 1632 | 2017-04-24 16:44:03.226 plugin-container[1634:7591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484b, name = 'com.apple.tsm.portname' 16:44:03 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:44:03 INFO - PID 1632 | 2017-04-24 16:44:03.229 plugin-container[1634:7591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 16:44:03 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:44:03 INFO - PID 1632 | 2017-04-24 16:44:03.229 plugin-container[1634:7591] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:44:03 INFO - PID 1632 | __metrics Screen width/height:1600/1200 16:44:03 INFO - PID 1632 | colorDepth:24 16:44:03 INFO - PID 1632 | Browser inner width/height: 1024/689 16:44:03 INFO - PID 1632 | __metrics 16:44:03 ERROR - PID 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 16:44:04 INFO - TEST-INFO | 1632: exit 0 16:44:04 INFO - Browser initialized. 16:44:04 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpC8Om0R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:06 INFO - PID 1635 | 2017-04-24 16:44:06.813 plugin-container[1636:7717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 16:44:06 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:44:06 INFO - PID 1635 | 2017-04-24 16:44:06.813 plugin-container[1636:7717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 16:44:06 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:44:06 INFO - PID 1635 | 2017-04-24 16:44:06.813 plugin-container[1636:7717] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:44:16 INFO - PID 1635 | RSS: Main: 235323392 16:44:16 INFO - PID 1635 | 16:47:20 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 16:47:22 INFO - PID 1635 | RSS: Main: 258854912 16:47:22 INFO - PID 1635 | 16:49:04 INFO - PID 1635 | ************************* 16:49:04 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 16:49:04 INFO - PID 1635 | 16:49:04 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:04 INFO - PID 1635 | Full stack: 16:49:04 INFO - PID 1635 | ************************* 16:49:04 INFO - PID 1635 | ************************* 16:49:04 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 16:49:04 INFO - PID 1635 | 16:49:04 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:04 INFO - PID 1635 | Full stack: 16:49:04 INFO - PID 1635 | ************************* 16:49:04 INFO - PID 1635 | ************************* 16:49:04 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 16:49:04 INFO - PID 1635 | 16:49:04 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:04 INFO - PID 1635 | Full stack: 16:49:04 INFO - PID 1635 | ************************* 16:49:04 INFO - PID 1635 | ************************* 16:49:04 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 16:49:04 INFO - PID 1635 | 16:49:04 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:04 INFO - PID 1635 | Full stack: 16:49:04 INFO - PID 1635 | ************************* 16:50:23 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 16:50:24 INFO - PID 1635 | RSS: Main: 261283840 16:50:24 INFO - PID 1635 | 16:53:26 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 16:53:26 INFO - PID 1635 | RSS: Main: 270065664 16:53:26 INFO - PID 1635 | 16:56:28 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 16:56:29 INFO - PID 1635 | RSS: Main: 263143424 16:56:29 INFO - PID 1635 | 16:59:32 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 16:59:32 INFO - PID 1635 | RSS: Main: 271736832 16:59:32 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 17:02:34 INFO - PID 1635 | RSS: Main: 266362880 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | __start_tp_report 17:02:34 INFO - PID 1635 | _x_x_mozilla_page_load 17:02:34 INFO - PID 1635 | _x_x_mozilla_page_load_details 17:02:34 INFO - PID 1635 | |i|pagename|runs| 17:02:34 INFO - PID 1635 | |0;dojo.html;2997.745191658709;3579.6420357964207;3614.945775813365;3640.7451478396524;3641.362761516734;6074.757009719617;6249.687515624218;6255.311915689276;6255.843603909904;6273.059041143831;6111.166351794765;6125.449118208402;6158.815235542929;6191.721372538235;6228.688565571726;5373.731313434332;5400.91898621521;5433.755481003344;5478.863028424302;5518.33779946405;5371.892562148755;5453.2092846537225;5517.282753242093;5531.751071201806;5531.834044978657;5339.172428273624;5378.300820893259;5465.289512363367;5469.56243500519;5503;5410.404855465896;5412.566994640459;5440.374356948962;5448.264484294648;5488.984537860469;5331.5201631853315;5372.892542149135;5374.650647707926;5378.46215378463;5435.157550579666;5148.712821794551;5651.180578816049;6067.7572897084065;6108.706347746985;6156.445919867188;6634.834129146761;6676.998450232455;6688.732450701966;6703.430208432241;6710.261871194165;6782.593044417302;6788.389044985975;6802.4217941475035;6811.25076241613;6815.897761533581;6135.171422439398;6149.846253843601;6373.776917807901;6387.776427825051;6398.9040164397575;6616.801495955129;6821.590704557742;6848.520603557803;6907.792766217021;6928.411085057826;5635.971820140955;5669.121286200645;5788.88422231553;6151.415615516608;6394.072859435356;5545.334559852843;6679.699413526403;6702.865942681216;6736.1916570010935;6743;6369.5541312108635;6426.132472116298;6570.704318305688;6646.734130634721;6651.833704157338;6430.5177111715875;6566.212054553484;6583.604983700993;6644.534882558271;6662.067310576524;5299.6025298102795;5305.283786688748;5323.095073837457;5335.653182543122;5355.437679043722;4689.179393606105;4715.056988602293;4716.457607375196;4732.810687572527;4755.738434386142;6119.807225076679;6180.103884936659;6267.2792628847355;6365.172527571479;6423.325550817191;6749.898751518731;6766.458683305324;6769.830754231184;6781.593104413751;6793.864122717518;6326.557141000178;6329.905051424233;6342.8414289642205;6376.266729326187;6417;5717.199592057115;5778.479936805707;5850;5854.7072646367515;5877.588568800228;6912.308769123048;6920.238773734885;6946.270641582763;6965.686544105426;6972.721091156297;6694.83262918431;6767.154105736783;6786.864262714619;6795.082663840319;6796.422304104009;5630.4369563045;6640.634765087773;6743.460523158037;6874.725010999504;6902.551334163263;6605.801825945229;6671.499637527302;6684.565503242468;6685.164354455693;6705.295943926013;5624.74688639004;6206.379362063757;6783.525153239423;6786.253512113763;6807.421369183675;6285.277193122666;6295.496360291258;6396.584222025554;6518.054882042172;6528.477721782341;6477.222733272038;6536.444402225674;6542.803715888531;6548.214214294315;6552.213734351908;5379.273798037371;6201.441870231701;6395.296517383177;6407.391297826699;6415.101885735908;6294.339094395205;6304.810855674337;6360;6466.708998095191;6528.869422611616;5248.947510524846;6338.683065846782;6395.776147834804;6396.296407395276;6407 17:02:34 INFO - PID 1635 | |1;ext.html;722.8048426924727;805.8227190018196;822.4078663362379;1245.5142494427175;1268.6638040919163;36835.26329473409;37844.864654060424;37854;37898;37938.810305948435;32418.8379058105;36921.89234322968;38016.619833801655;38146.61853381465;38226.617733822655;6819.48853835963;7707.190744971754;8241.299489543397;8446.408751387406;8489.66041358345;8388.748337549883;8410.243078122967;8427.367947403938;8505.192006759378;8514.233718965292;8463.703770368038;8493.532855692934;8524.06235314115;8524.403291769579;8540.871886921701;8444.282236009947;8486.108958559385;8487.872681909776;8539;8542.74371768848;8360.163983601591;8405.285550728195;8414.49513029214;8420.957895210484;8425.915740842574;36373.81813090944;36437.27125457476;36560.81719591412;36593.81703091467;36691.4496282556;3049.329147587527;3571.964280357189;3578.4632305154173;3578.946315805265;3587.336342776595;26259.606105908428;29274.829006839915;30419.935302264537;30492.695073049206;30569.082927511987;2882.3802882380387;3169.3978144152766;3182.6499085100622;3193.1857376369107;3194.3132226571397;287643;306908;308670;311287;311467;47315;47384;47449.52550474451;47540.762296188295;47630.761846190544;49101.754491227315;49155.754221228664;53132.734336328846;53926;54320.91358172814;14120;14217;14224.21766802815;14262.57212283633;14280.928595357165;9164.404313719588;9381.155695987394;11249.775004499865;11331.546738130548;11367.658970230907;11600.955913967784;13376.866231337563;13810.309484525733;13846.9614778892;13848.584542463743;6071.423214794588;6080.513558915276;6109.877802443926;6111.083337499411;6128.17269668598;872.5855218771032;989.1987490133015;1001.1340190734962;1014.3153371474225;1035.6271742172812;20182;20535.691964620542;24220.39449013789;24514.877425612758;24695.753042469347;1042.2287507244585;1127.3574062784298;1145.9369734664674;1149.6436104807538;1158.4671051316489;12492.375381230902;12581.559645412366;12688.87311126877;12724.681882952815;12774.914132298672;314492;314945;315493.42253288586;316347.4182629072;317441;53864.46135538673;53874.7306263474;54120;54159.458405416226;54257;1446.6744982379091;1461.3423959218394;1503.639126609606;1506.6685329227553;1520.7718842173763;23738.643920341554;23828.642570361113;23865;23878.283651490485;23888.761112388653;37786.43320350142;37795.81102094472;37799.24401512009;37893;38027.80986095052;273016;273064;273211;273384;274572;27488.45023099567;28262.869485221185;33253.00240992774;35064.948051558495;36429.63570364368;40994.1801163981;41587.75236742903;45382.77308613436;45388.54611453843;45456;28916.27709307284;29784.851075744482;30572.541411878396;31518.212044699067;31719;30488.695113049474;30950;30980;31416;31833.681663183073;30149.34178620197;30647.54028689527;35536.93389198328;36872.44691329686;37599.248015040095;25053.74946250514;31286.530702039032;31933.36133277275;32115.83942080368;32462.83768581142;20369.69445458349;21068.789312106685;21525.92370381506;24316.39209019718;24371.39071523155 17:02:34 INFO - PID 1635 | |2;jquery.html;388.2313020219966;431.7733190075212;432.3190974215609;440.89859332353547;464.064909207946;18236.361727339547;20068.799312006875;20761.896190519063;20945.47636309093;20951.37145885624;17981.37065202718;21253.787462125376;21366.465838354048;21612.351629451103;21746.912654367297;6009.549283803711;6254.280072979944;6315.368463153671;6323.9051414228825;6324.936750632503;6012.308584512772;6139.38606139387;6188.938110618881;6294.2761582417925;6303;6213.782517611885;6266.342034086424;6268.247810262752;6272.2159730033745;6285.717142728588;6051.243594550681;6129.601575897597;6165.1677023601915;6205.038219076027;6231.750729970796;5475.869680864299;5480.095784195603;5490.615656904019;5504.422035686235;5519.806806761784;23871.522569548513;26869.32826679329;26907.86546067277;27242.5913611296;27451.90192392302;2170.9565808683737;2244.9775502244934;2263.2870645746702;2291.8395712300144;2292.094622624071;17539.912300438416;17586;17890.55273618157;18081.909590452095;18231.17959691817;2159.5788821179717;2207.4591725027312;2223.1885361842974;2227.9331620051425;2233.2965115988573;146417;148052;148090;148477;157898.63152052727;12254.448549815279;12833.871661283454;12894.80657790134;12907.096503244682;12941.417636206394;13606.727865442635;13699.383527741076;16166.43417480406;16445.91777041107;16472;8764.298856091498;8959.686410975715;8962.73111806647;9001.954990225007;9100.544972751335;8435;8480.957595211985;8532.744017679479;8635.309175265964;8636.95681521601;6479.546431749733;7745.91557181995;7802.180771019075;7827.9608601956625;7889.566073865993;2166.155199472207;2181.4328274648706;2184.6395344767934;2188.7811218877987;2332.323626148398;972.1493693018608;990.1880458024351;994.3188915592842;1008.2287050406445;1030.6907927621833;19410.32063877786;19511.90244048799;19743.012849357474;20129.698054529195;20538.486537836674;1001.2390583156707;1022.5602990713916;1026.7997740440692;1033.6743925663393;1037.6990672704983;10421.843672344921;10693.625723099654;10705;10720.946395267974;10738.463076846127;559048;565458.0725156504;569562;571281;572759;102808;103119.93760124755;125761.37119314345;127436.3581910737;127650;1158.2182027131653;1181.5155786127818;1194.6654936617588;1248.36333469931;1250.737345157509;20265.30795028222;21338.35984920455;21367.8931605341;21375.572488550453;21532.246371377554;50026.49973500364;51744;55814;56371.154432684365;57752;76378.03542769702;77643.61178194072;77853.61073194598;79442.60278698569;79449;8718.08460111679;8805;9127.178553930178;9240.399374040666;12805.551805686757;13879.444822206999;14151.363188656742;14157.292135393394;14792.704145916807;14951.626209344853;11538.826917596074;11848.585299514476;11958;12075.335856527976;12145.570885823048;10557;10768.030877221088;11040.779184416106;11150.553977840795;11661.300321980709;9524.571394287412;12071.094667900119;12107.636770896886;12254.754904901674;12364.381780910739;12798.680032998876;13227.148199252304;13271.412074645352;13370.130941488773;13485.056046076681;10920.853310402294;11889.464974076014;12057.57798477049;12111.515539378326;12132 17:02:34 INFO - PID 1635 | |3;mootools.html;1430.8998370114093;1467.787170860226;1470.7352676518221;1480.5046902628342;1494.8654621084104;11424.657260282194;11886.227395219305;11919.702007449818;11920.701982450442;12271.509139634427;11987.520499180022;12011.339376334297;12142.757144857098;12154.33151176685;12157.635270941864;2077.24180674054;2577.497388009339;2577.9484410311784;2584.728603496634;2587.081586036958;2499.8750062496892;2526.570483017882;2533.1134103063873;2536.568783306833;2552.438463538019;2501.17461237792;2531.5696331623667;2540.2252313044514;2543.1480454047914;2553.6297236900637;2128;2476.3561474016706;2513.321403221129;2543.2878793937543;2545.5290771207387;2045.1614837916384;2440.12155623977;2441.2676197140963;2444.8899799508886;2446.7797898189247;10442.947785261025;11168.385738784364;11686.649400517997;11919.582814601534;11959.940200298943;6709.429698475636;6955.269696681826;6958.304169583002;6959.408450281732;6976.476764242651;4087.4686290782006;4413.0732546165345;4468.2850743881145;4481.395011673415;4518.43519560055;1235.2279825109306;1249.900007999358;1286.9549565765153;1314.9802752958713;1317.7562151002096;14308.57074287773;16090.919545402197;16235.107069111195;16680.916595417068;17053.573660658458;5586.664800112007;5813.854653633608;5916.970415147983;5970.373110823388;5975.731092100779;10094.394336339843;12452.626421207378;12505.812412813815;12508.499660013498;12537.498500059895;6718.596884186964;6725.66371681414;6726.22648395431;6735.494837887178;6755.763548275787;6050.273967123973;6263.843403914939;6269.216347956505;6336.20797400325;6337.207849018872;4362.781860906942;4433.778311084433;4449.509414346166;4510.300903359985;4543.182227199136;1286.7362190750873;1311.7573248948975;1311.8360204974379;1327.6879933215687;1328.93355332233;773.9148693643695;795.9135186505196;803.5339503088195;812.1837553258937;818.300353198019;6260.718267677874;6263.530235232376;6423.96788016057;6493.350664933469;6505.447037001813;504.553470178887;585.4409039367393;594.5629961977943;597.1430996520007;614.5126407636644;4067.8372865085066;4214.17823524416;4318.114786468766;4392.758398288125;4476;14822.88719368923;15094.094354338775;15110.320035598425;15305.540833774781;15326.846731532765;14914.403423862925;15262;15324.693506129815;15332.463363782213;15349.002314849498;7629.580373079423;8610.311175105977;8727.825443491094;8734.95632521846;8761.868571971425;5658.519025882846;6251.624902505864;6396.520260980352;6820.488463365168;7223.638818059181;12619.11666183395;12646.683832904251;12654.240745555297;12735.80896286538;12895.48418063267;11601.593944211912;13133.868661313647;13309.136720858894;13924.860751392356;14066.296685165906;8606.612702428281;8809.339299552686;8849.24781393563;8864.113588641343;8866.512341821262;10819.891801081889;10831.566737330419;10858.565657373616;10932.234743568191;10964.232503724663;9246.398984066014;9269.953650231706;9277.814443710953;9289.21041711462;9342.673006444742;8892.73321800347;9048.819023619359;9079;9089.545522723969;9179.770505737142;8209.932708747825;8239.340852731886;8249.133840946613;8329.208725171098;8350.164983501601;5212.348456442945;6027.095935609694;6156.753729850756;6212.596181248205;6274.152989346379;6022.277326720821;6111.8777624446375;6114.816555503342;6278.529110316836;6465.2564955030775 17:02:34 INFO - PID 1635 | |4;prototype.html;415.7235438433441;416.084613849531;419.702011571784;421.65424352031346;427.7027465911193;5849.830033993202;6144;6232.880820521022;6301.180846489956;6374.418360563967;5072.315237442944;6110.450059494645;6150.815475535741;6217.5958562693395;6219.533534984883;3847.8845634631007;4369.847055353063;4549.749763762991;4587.42657167854;4745.881352966169;4570.268756998881;4574.931376029345;4578.175928332898;4578.450585929693;4605.401297831278;4123.9793801030955;4531.365608814768;4552.133625213663;4556.84051058213;4575.496695363508;4441.689081764262;4501.684882058257;4516.7578915798085;4534.455865296152;4548.135854187693;3861.1119442528375;3865.864694735699;3873.748206366577;3886.6113388661192;3889.7860617666015;5242.580593552545;6113.908291375633;6123.2652081750475;6126.142340072349;6153.2000839890525;5264.710440925747;5422.674639521641;5424.511793938525;5479.1781232815;5479.506844383985;5730.68481233532;6654.733810647568;6680.83297917551;6681.966590167067;6688.565243259172;4342.761148136851;4444.177827101964;4456.353828694853;4475.776211189427;4484.2376795944765;6174.691265436711;6755.729770809162;6764.666190164386;6959.1996920353795;6992.021117043618;4280.379344994958;4309.827606895689;4424.778761061998;4518.548145185455;4538.455385353779;4134.524529679125;4147.880072380441;4496.19068567661;4546.499885012646;4613.746243956548;4435.489918659331;4919.704817710949;5032.748362581856;5200.2979597754575;5463.508284254436;5845.09401042839;6387.041943708481;6675.632840193739;6719.664016799238;6736.8989465158065;1362.9659258518418;1426.6504706347012;1544.5752418085117;1571.8035245594301;1580.0519688186996;1011.9241056920761;1019.2406657040552;1031.9122874555746;1034.4724190662816;1045.8535804987307;5569.8024924641395;5875.795461930294;6392.776252831129;6396.776112836028;6419.711112999927;6914;6932.306769323028;6966.989786480932;6984.61584612841;6992.755253566101;5006.1739812930455;5057.898842023139;5712.400197979236;6052.455279024909;6334.651594162366;2981;3027.8940237091597;3133.6396314424132;3325.434676105068;3607.5310209672575;6291.5281353898645;6793.98090286461;6917.654117294115;7090.255523170096;7108.822279443055;5537.916931246034;6698;6722.890723030743;6820.761273355409;7063.399611033017;6832.829179270459;7012.789616311621;7037.683304251424;7111.573305601681;7111.715531378687;6903.1716194057035;6913.481488888454;6915.723371065303;6927.134108236471;6973.6164510952385;6454.386833250834;6695.852949113909;6734.8653026940165;6736.259011508828;6822.897656535255;6401.583897046677;6607.141071660653;7020;7228.674709637974;7291.203493222794;4019.1358857845703;4556;4564.360989461412;4568.840090596813;4589.334546490807;6595.637239951657;6774.933645238052;6892.207396149507;7007.789766307019;7026.508144429841;5245.950809837971;6187.978983467678;6325.841853953504;6724.226713927961;6781.321867813179;5548.306461692288;6468.062130991074;6608.173978252718;6694.497912656473;6723.4285085766305;5766.682832444256;5943.7518121195035;5981.401859814157;6070.696465176812;6582.76960306387;5471.932973070213;5521.889562208814;6056;6695.4308883745425;6734.865302693821;5300.9734951325;5468.972655136698;6451.387118223761;6519.762154599548;6551.44312733423 17:02:34 INFO - PID 1635 | |5;yui.html;818.116434251009;832.604512856393;842.3387640702048;852.441650718779;855.7005048233117;15874.920625396871;16247.43133990309;16280.511584652464;18486.352977645784;19151.329703460382;17527.91236043818;17564.560885977826;17705.55736106598;17747.91126044368;18002.09989500523;935.9906400935988;960.4045491795061;964.4406244378243;966.3284017607765;966.7921396899665;956.077385323163;959.94720290384;964.344245912779;964.9083337083001;965.4255717847869;1017.653997640802;1037.3516552154904;1038.9220808439359;1038.9480525973709;1040.5629635553048;1013.4324778124237;1028.8611037509916;1032.5560009196006;1032.901874321942;1036.5542816588863;669.6752075243503;712.479889680531;729.9781006569812;741.8850078237828;745.9925400746032;16334.75497867533;16439.589010274718;16467.505974820775;16515.91742041282;16532.421365252158;16092.195390230441;16437.506874793777;16741.567978564366;16921.915390422968;16930.322787088502;13675.31623418835;13859.37632806516;13910.791338129937;13981.650458738512;13985.021048526607;3452.9482057769155;3460.8615655373756;3517.718582513393;3520.7359448041498;3523.3129539739502;99466.50800238003;100271.99999999927;124800;125977;127152;13229.272390018641;13426.328683565978;13487;13516.459341626225;13561.711637394432;18580.349687760863;25172.24483265505;25717.74282257191;25725.485490290088;25731;5092.541671249532;6365.395287447685;6417.9679101605125;6422.903656445157;6462;3966.2662407454714;4040.676745860324;4044.3326851069833;4063.5733248009124;4074.124063326399;4115.156392939441;4330.0906809569715;4361.01877077655;4394.846180383671;4451.020775429401;925.5603588295505;925.847235206197;936.8313703533294;950.7860731335394;951.9762005949907;612.3233826621608;617.6658417817492;624.7844493649684;624.9875002500015;658.7266284491978;10961.780764384826;10974.451277436256;12042.458089385998;12056.819147712791;12147.331896745587;600.5915977135589;609.3632154398664;610.5390430225241;634.501915995941;637.5632691606264;5407;5561.026820306511;5596.748146333425;5710.543156547466;5728.570357223141;102847.4857625722;105881.47059264808;105895.47052264844;106665.46667266614;108948;85964.57017714871;89946.55026724824;92281.53859230794;93387.53306233426;94124.52937735405;58281;60983.69508152431;80161;81256;81392.59303703562;10058.647947321808;10568.894311057098;10873.130149587856;11302.491387887729;11498.195126341076;42131.789341054326;42230.577694223895;42626.78686606547;43227.78386108049;43589.12821743611;53880;54234.64413389539;54339.3698189055;54386.728066361;55672.44327556673;10750.139988801033;11778;12713.36433178356;13907.165570065828;13932.02475826723;18077.186526606598;18681.53296167607;18702.53243668865;18764.906175469034;18818.905905470932;16330.673386531966;16595.668086637957;16966.830331696525;17178.39875604348;17458.30166793314;16659.25033373477;16685.08232047249;16844.410445634345;17104.315827366765;17348.39280625172;14538.85461145375;14558.854411456174;14603.926980365455;14680.926595366955;14700.191489468181;11584.304941703525;11883.524659013543;11937.343446110548;12088.637340879788;12102.971247443713;13139.802902956271;13554.525591604246;13587.360779140812;13758.65603359924;13772.246248280973 17:02:34 INFO - PID 1635 | __end_tp_report 17:02:34 INFO - PID 1635 | __start_cc_report 17:02:34 INFO - PID 1635 | _x_x_mozilla_cycle_collect,419 17:02:34 INFO - PID 1635 | __end_cc_report 17:02:34 INFO - PID 1635 | __startTimestamp1493078554763__endTimestamp 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | ------- Summary: start ------- 17:02:34 INFO - PID 1635 | Number of tests: 6 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:6099.52 Median:6338.68 stddev:737.23 (11.6%) stddev-sans-first:698.18 17:02:34 INFO - PID 1635 | Values: 2997.7 3579.6 3614.9 3640.7 3641.4 6074.8 6249.7 6255.3 6255.8 6273.1 6111.2 6125.4 6158.8 6191.7 6228.7 5373.7 5400.9 5433.8 5478.9 5518.3 5371.9 5453.2 5517.3 5531.8 5531.8 5339.2 5378.3 5465.3 5469.6 5503.0 5410.4 5412.6 5440.4 5448.3 5489.0 5331.5 5372.9 5374.7 5378.5 5435.2 5148.7 5651.2 6067.8 6108.7 6156.4 6634.8 6677.0 6688.7 6703.4 6710.3 6782.6 6788.4 6802.4 6811.3 6815.9 6135.2 6149.8 6373.8 6387.8 6398.9 6616.8 6821.6 6848.5 6907.8 6928.4 5636.0 5669.1 5788.9 6151.4 6394.1 5545.3 6679.7 6702.9 6736.2 6743.0 6369.6 6426.1 6570.7 6646.7 6651.8 6430.5 6566.2 6583.6 6644.5 6662.1 5299.6 5305.3 5323.1 5335.7 5355.4 4689.2 4715.1 4716.5 4732.8 4755.7 6119.8 6180.1 6267.3 6365.2 6423.3 6749.9 6766.5 6769.8 6781.6 6793.9 6326.6 6329.9 6342.8 6376.3 6417.0 5717.2 5778.5 5850.0 5854.7 5877.6 6912.3 6920.2 6946.3 6965.7 6972.7 6694.8 6767.2 6786.9 6795.1 6796.4 5630.4 6640.6 6743.5 6874.7 6902.6 6605.8 6671.5 6684.6 6685.2 6705.3 5624.7 6206.4 6783.5 6786.3 6807.4 6285.3 6295.5 6396.6 6518.1 6528.5 6477.2 6536.4 6542.8 6548.2 6552.2 5379.3 6201.4 6395.3 6407.4 6415.1 6294.3 6304.8 6360.0 6466.7 6528.9 5248.9 6338.7 6395.8 6396.3 6407.0 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:44639.42 Median:17655.08 stddev:78371.69 (443.9%) stddev-sans-first:78522.18 17:02:34 INFO - PID 1635 | Values: 722.8 805.8 822.4 1245.5 1268.7 36835.3 37844.9 37854.0 37898.0 37938.8 32418.8 36921.9 38016.6 38146.6 38226.6 6819.5 7707.2 8241.3 8446.4 8489.7 8388.7 8410.2 8427.4 8505.2 8514.2 8463.7 8493.5 8524.1 8524.4 8540.9 8444.3 8486.1 8487.9 8539.0 8542.7 8360.2 8405.3 8414.5 8421.0 8425.9 36373.8 36437.3 36560.8 36593.8 36691.4 3049.3 3572.0 3578.5 3578.9 3587.3 26259.6 29274.8 30419.9 30492.7 30569.1 2882.4 3169.4 3182.6 3193.2 3194.3 287643.0 306908.0 308670.0 311287.0 311467.0 47315.0 47384.0 47449.5 47540.8 47630.8 49101.8 49155.8 53132.7 53926.0 54320.9 14120.0 14217.0 14224.2 14262.6 14280.9 9164.4 9381.2 11249.8 11331.5 11367.7 11601.0 13376.9 13810.3 13847.0 13848.6 6071.4 6080.5 6109.9 6111.1 6128.2 872.6 989.2 1001.1 1014.3 1035.6 20182.0 20535.7 24220.4 24514.9 24695.8 1042.2 1127.4 1145.9 1149.6 1158.5 12492.4 12581.6 12688.9 12724.7 12774.9 314492.0 314945.0 315493.4 316347.4 317441.0 53864.5 53874.7 54120.0 54159.5 54257.0 1446.7 1461.3 1503.6 1506.7 1520.8 23738.6 23828.6 23865.0 23878.3 23888.8 37786.4 37795.8 37799.2 37893.0 38027.8 273016.0 273064.0 273211.0 273384.0 274572.0 27488.5 28262.9 33253.0 35064.9 36429.6 40994.2 41587.8 45382.8 45388.5 45456.0 28916.3 29784.9 30572.5 31518.2 31719.0 30488.7 30950.0 30980.0 31416.0 31833.7 30149.3 30647.5 35536.9 36872.4 37599.2 25053.7 31286.5 31933.4 32115.8 32462.8 20369.7 21068.8 21525.9 24316.4 24371.4 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:35606.79 Median:11885.97 stddev:95523.46 (803.7%) stddev-sans-first:95754.82 17:02:34 INFO - PID 1635 | Values: 388.2 431.8 432.3 440.9 464.1 18236.4 20068.8 20761.9 20945.5 20951.4 17981.4 21253.8 21366.5 21612.4 21746.9 6009.5 6254.3 6315.4 6323.9 6324.9 6012.3 6139.4 6188.9 6294.3 6303.0 6213.8 6266.3 6268.2 6272.2 6285.7 6051.2 6129.6 6165.2 6205.0 6231.8 5475.9 5480.1 5490.6 5504.4 5519.8 23871.5 26869.3 26907.9 27242.6 27451.9 2171.0 2245.0 2263.3 2291.8 2292.1 17539.9 17586.0 17890.6 18081.9 18231.2 2159.6 2207.5 2223.2 2227.9 2233.3 146417.0 148052.0 148090.0 148477.0 157898.6 12254.4 12833.9 12894.8 12907.1 12941.4 13606.7 13699.4 16166.4 16445.9 16472.0 8764.3 8959.7 8962.7 9002.0 9100.5 8435.0 8481.0 8532.7 8635.3 8637.0 6479.5 7745.9 7802.2 7828.0 7889.6 2166.2 2181.4 2184.6 2188.8 2332.3 972.1 990.2 994.3 1008.2 1030.7 19410.3 19511.9 19743.0 20129.7 20538.5 1001.2 1022.6 1026.8 1033.7 1037.7 10421.8 10693.6 10705.0 10720.9 10738.5 559048.0 565458.1 569562.0 571281.0 572759.0 102808.0 103119.9 125761.4 127436.4 127650.0 1158.2 1181.5 1194.7 1248.4 1250.7 20265.3 21338.4 21367.9 21375.6 21532.2 50026.5 51744.0 55814.0 56371.2 57752.0 76378.0 77643.6 77853.6 79442.6 79449.0 8718.1 8805.0 9127.2 9240.4 12805.6 13879.4 14151.4 14157.3 14792.7 14951.6 11538.8 11848.6 11958.0 12075.3 12145.6 10557.0 10768.0 11040.8 11150.6 11661.3 9524.6 12071.1 12107.6 12254.8 12364.4 12798.7 13227.1 13271.4 13370.1 13485.1 10920.9 11889.5 12057.6 12111.5 12132.0 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7119.60 Median:4077.65 stddev:4484.33 (110.0%) stddev-sans-first:4476.54 17:02:34 INFO - PID 1635 | Values: 1430.9 1467.8 1470.7 1480.5 1494.9 11424.7 11886.2 11919.7 11920.7 12271.5 11987.5 12011.3 12142.8 12154.3 12157.6 2077.2 2577.5 2577.9 2584.7 2587.1 2499.9 2526.6 2533.1 2536.6 2552.4 2501.2 2531.6 2540.2 2543.1 2553.6 2128.0 2476.4 2513.3 2543.3 2545.5 2045.2 2440.1 2441.3 2444.9 2446.8 10442.9 11168.4 11686.6 11919.6 11959.9 6709.4 6955.3 6958.3 6959.4 6976.5 4087.5 4413.1 4468.3 4481.4 4518.4 1235.2 1249.9 1287.0 1315.0 1317.8 14308.6 16090.9 16235.1 16680.9 17053.6 5586.7 5813.9 5917.0 5970.4 5975.7 10094.4 12452.6 12505.8 12508.5 12537.5 6718.6 6725.7 6726.2 6735.5 6755.8 6050.3 6263.8 6269.2 6336.2 6337.2 4362.8 4433.8 4449.5 4510.3 4543.2 1286.7 1311.8 1311.8 1327.7 1328.9 773.9 795.9 803.5 812.2 818.3 6260.7 6263.5 6424.0 6493.4 6505.4 504.6 585.4 594.6 597.1 614.5 4067.8 4214.2 4318.1 4392.8 4476.0 14822.9 15094.1 15110.3 15305.5 15326.8 14914.4 15262.0 15324.7 15332.5 15349.0 7629.6 8610.3 8727.8 8735.0 8761.9 5658.5 6251.6 6396.5 6820.5 7223.6 12619.1 12646.7 12654.2 12735.8 12895.5 11601.6 13133.9 13309.1 13924.9 14066.3 8606.6 8809.3 8849.2 8864.1 8866.5 10819.9 10831.6 10858.6 10932.2 10964.2 9246.4 9270.0 9277.8 9289.2 9342.7 8892.7 9048.8 9079.0 9089.5 9179.8 8209.9 8239.3 8249.1 8329.2 8350.2 5212.3 6027.1 6156.8 6212.6 6274.2 6022.3 6111.9 6114.8 6278.5 6465.3 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5314.98 Median:5847.46 stddev:1691.07 (28.9%) stddev-sans-first:1655.35 17:02:34 INFO - PID 1635 | Values: 415.7 416.1 419.7 421.7 427.7 5849.8 6144.0 6232.9 6301.2 6374.4 5072.3 6110.5 6150.8 6217.6 6219.5 3847.9 4369.8 4549.7 4587.4 4745.9 4570.3 4574.9 4578.2 4578.5 4605.4 4124.0 4531.4 4552.1 4556.8 4575.5 4441.7 4501.7 4516.8 4534.5 4548.1 3861.1 3865.9 3873.7 3886.6 3889.8 5242.6 6113.9 6123.3 6126.1 6153.2 5264.7 5422.7 5424.5 5479.2 5479.5 5730.7 6654.7 6680.8 6682.0 6688.6 4342.8 4444.2 4456.4 4475.8 4484.2 6174.7 6755.7 6764.7 6959.2 6992.0 4280.4 4309.8 4424.8 4518.5 4538.5 4134.5 4147.9 4496.2 4546.5 4613.7 4435.5 4919.7 5032.7 5200.3 5463.5 5845.1 6387.0 6675.6 6719.7 6736.9 1363.0 1426.7 1544.6 1571.8 1580.1 1011.9 1019.2 1031.9 1034.5 1045.9 5569.8 5875.8 6392.8 6396.8 6419.7 6914.0 6932.3 6967.0 6984.6 6992.8 5006.2 5057.9 5712.4 6052.5 6334.7 2981.0 3027.9 3133.6 3325.4 3607.5 6291.5 6794.0 6917.7 7090.3 7108.8 5537.9 6698.0 6722.9 6820.8 7063.4 6832.8 7012.8 7037.7 7111.6 7111.7 6903.2 6913.5 6915.7 6927.1 6973.6 6454.4 6695.9 6734.9 6736.3 6822.9 6401.6 6607.1 7020.0 7228.7 7291.2 4019.1 4556.0 4564.4 4568.8 4589.3 6595.6 6774.9 6892.2 7007.8 7026.5 5246.0 6188.0 6325.8 6724.2 6781.3 5548.3 6468.1 6608.2 6694.5 6723.4 5766.7 5943.8 5981.4 6070.7 6582.8 5471.9 5521.9 6056.0 6695.4 6734.9 5301.0 5469.0 6451.4 6519.8 6551.4 17:02:34 INFO - PID 1635 | 17:02:34 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21136.48 Median:18692.03 stddev:29554.50 (158.1%) stddev-sans-first:29598.03 17:02:34 INFO - PID 1635 | Values: 818.1 832.6 842.3 852.4 855.7 15874.9 16247.4 16280.5 18486.4 19151.3 17527.9 17564.6 17705.6 17747.9 18002.1 936.0 960.4 964.4 966.3 966.8 956.1 959.9 964.3 964.9 965.4 1017.7 1037.4 1038.9 1038.9 1040.6 1013.4 1028.9 1032.6 1032.9 1036.6 669.7 712.5 730.0 741.9 746.0 16334.8 16439.6 16467.5 16515.9 16532.4 16092.2 16437.5 16741.6 16921.9 16930.3 13675.3 13859.4 13910.8 13981.7 13985.0 3452.9 3460.9 3517.7 3520.7 3523.3 99466.5 100272.0 124800.0 125977.0 127152.0 13229.3 13426.3 13487.0 13516.5 13561.7 18580.3 25172.2 25717.7 25725.5 25731.0 5092.5 6365.4 6418.0 6422.9 6462.0 3966.3 4040.7 4044.3 4063.6 4074.1 4115.2 4330.1 4361.0 4394.8 4451.0 925.6 925.8 936.8 950.8 952.0 612.3 617.7 624.8 625.0 658.7 10961.8 10974.5 12042.5 12056.8 12147.3 600.6 609.4 610.5 634.5 637.6 5407.0 5561.0 5596.7 5710.5 5728.6 102847.5 105881.5 105895.5 106665.5 108948.0 85964.6 89946.6 92281.5 93387.5 94124.5 58281.0 60983.7 80161.0 81256.0 81392.6 10058.6 10568.9 10873.1 11302.5 11498.2 42131.8 42230.6 42626.8 43227.8 43589.1 53880.0 54234.6 54339.4 54386.7 55672.4 10750.1 11778.0 12713.4 13907.2 13932.0 18077.2 18681.5 18702.5 18764.9 18818.9 16330.7 16595.7 16966.8 17178.4 17458.3 16659.3 16685.1 16844.4 17104.3 17348.4 14538.9 14558.9 14603.9 14680.9 14700.2 11584.3 11883.5 11937.3 12088.6 12103.0 13139.8 13554.5 13587.4 13758.7 13772.2 17:02:34 INFO - PID 1635 | -------- Summary: end -------- 17:02:34 INFO - PID 1635 | 17:02:35 INFO - TEST-INFO | 1635: exit 0 17:02:35 INFO - TEST-OK | dromaeo_css | took 1115245ms 17:02:35 INFO - TEST-START | kraken 17:02:35 INFO - operating with platform_type : mac_ 17:02:35 INFO - Initialising browser for kraken test... 17:02:35 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpvquKbF/profile http://localhost:49242/getInfo.html) 17:02:38 INFO - PID 1647 | 2017-04-24 17:02:38.210 plugin-container[1648:10152] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 17:02:38 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:02:38 INFO - PID 1647 | 2017-04-24 17:02:38.213 plugin-container[1648:10152] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 17:02:38 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:02:38 INFO - PID 1647 | 2017-04-24 17:02:38.213 plugin-container[1648:10152] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:02:38 INFO - PID 1647 | __metrics Screen width/height:1600/1200 17:02:38 INFO - PID 1647 | colorDepth:24 17:02:38 INFO - PID 1647 | Browser inner width/height: 1024/689 17:02:38 INFO - PID 1647 | __metrics 17:02:38 ERROR - PID 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 17:02:39 INFO - TEST-INFO | 1647: exit 0 17:02:39 INFO - Browser initialized. 17:02:39 INFO - Running cycle 1/1 for kraken test... 17:02:39 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpvquKbF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:41 INFO - PID 1649 | 2017-04-24 17:02:41.989 plugin-container[1650:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x944f, name = 'com.apple.tsm.portname' 17:02:41 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:02:41 INFO - PID 1649 | 2017-04-24 17:02:41.990 plugin-container[1650:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 17:02:41 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:02:41 INFO - PID 1649 | 2017-04-24 17:02:41.990 plugin-container[1650:10274] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:02:51 INFO - PID 1649 | RSS: Main: 236945408 17:02:51 INFO - PID 1649 | 17:02:54 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:55 INFO - PID 1649 | RSS: Main: 249057280 17:02:55 INFO - PID 1649 | 17:02:58 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 17:02:58 INFO - PID 1649 | RSS: Main: 257171456 17:02:58 INFO - PID 1649 | 17:03:02 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 17:03:02 INFO - PID 1649 | RSS: Main: 259874816 17:03:02 INFO - PID 1649 | 17:03:04 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 17:03:05 INFO - PID 1649 | RSS: Main: 261672960 17:03:05 INFO - PID 1649 | 17:03:07 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:03:08 INFO - PID 1649 | RSS: Main: 262180864 17:03:08 INFO - PID 1649 | 17:03:11 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 17:03:12 INFO - PID 1649 | RSS: Main: 267735040 17:03:12 INFO - PID 1649 | 17:03:15 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 17:03:15 INFO - PID 1649 | RSS: Main: 268894208 17:03:15 INFO - PID 1649 | 17:03:18 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 17:03:19 INFO - PID 1649 | RSS: Main: 268791808 17:03:19 INFO - PID 1649 | 17:03:20 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:21 INFO - PID 1649 | RSS: Main: 268087296 17:03:21 INFO - PID 1649 | 17:03:23 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:23 INFO - PID 1649 | RSS: Main: 268218368 17:03:23 INFO - PID 1649 | 17:03:26 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:26 INFO - PID 1649 | RSS: Main: 267829248 17:03:26 INFO - PID 1649 | 17:03:29 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:03:30 INFO - PID 1649 | RSS: Main: 268382208 17:03:30 INFO - PID 1649 | 17:03:33 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:34 INFO - PID 1649 | RSS: Main: 268496896 17:03:34 INFO - PID 1649 | 17:03:35 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 17:03:36 INFO - PID 1649 | RSS: Main: 269897728 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | __start_tp_report 17:03:36 INFO - PID 1649 | _x_x_mozilla_page_load 17:03:36 INFO - PID 1649 | _x_x_mozilla_page_load_details 17:03:36 INFO - PID 1649 | |i|pagename|runs| 17:03:36 INFO - PID 1649 | |0;ai-astar;101;113;113;115;114;113;114;114;115;112 17:03:36 INFO - PID 1649 | |1;audio-beat-detection;139;142;148;149;105;113;109;122;150;143 17:03:36 INFO - PID 1649 | |2;audio-dft;183;190;257;267;260;232;214;239;207;243 17:03:36 INFO - PID 1649 | |3;audio-fft;87;55;59;97;50;49;70;88;94;90 17:03:36 INFO - PID 1649 | |4;audio-oscillator;83;72;105;71;69;70;88;70;71;90 17:03:36 INFO - PID 1649 | |5;imaging-gaussian-blur;88;98;134;84;127;136;95;134;132;136 17:03:36 INFO - PID 1649 | |6;imaging-darkroom;97;97;105;97;96;98;97;146;151;96 17:03:36 INFO - PID 1649 | |7;imaging-desaturate;93;95;93;92;93;92;91;90;90;90 17:03:36 INFO - PID 1649 | |8;json-parse-financial;51;49;48;50;51;51;49;69;76;75 17:03:36 INFO - PID 1649 | |9;json-stringify-tinderbox;57;66;58;60;84;85;80;56;57;58 17:03:36 INFO - PID 1649 | |10;stanford-crypto-aes;101;107;109;74;92;105;84;77;104;106 17:03:36 INFO - PID 1649 | |11;stanford-crypto-ccm;148;133;137;133;140;139;136;141;197;156 17:03:36 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;183;190;178;184;184;182;181;185;182;172 17:03:36 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;71;69;58;74;98;96;99;55;68;92 17:03:36 INFO - PID 1649 | __end_tp_report 17:03:36 INFO - PID 1649 | __start_cc_report 17:03:36 INFO - PID 1649 | _x_x_mozilla_cycle_collect,984 17:03:36 INFO - PID 1649 | __end_cc_report 17:03:36 INFO - PID 1649 | __startTimestamp1493078616212__endTimestamp 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | ------- Summary: start ------- 17:03:36 INFO - PID 1649 | Number of tests: 14 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:4.12 (3.6%) stddev-sans-first:1.00 17:03:36 INFO - PID 1649 | Values: 101.0 113.0 113.0 115.0 114.0 113.0 114.0 114.0 115.0 112.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:142.50 stddev:17.82 (12.5%) stddev-sans-first:18.72 17:03:36 INFO - PID 1649 | Values: 139.0 142.0 148.0 149.0 105.0 113.0 109.0 122.0 150.0 143.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:229.20 Median:241.00 stddev:29.51 (12.2%) stddev-sans-first:26.14 17:03:36 INFO - PID 1649 | Values: 183.0 190.0 257.0 267.0 260.0 232.0 214.0 239.0 207.0 243.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:73.90 Median:87.50 stddev:19.30 (22.1%) stddev-sans-first:19.88 17:03:36 INFO - PID 1649 | Values: 87.0 55.0 59.0 97.0 50.0 49.0 70.0 88.0 94.0 90.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:71.50 stddev:12.17 (17.0%) stddev-sans-first:12.82 17:03:36 INFO - PID 1649 | Values: 83.0 72.0 105.0 71.0 69.0 70.0 88.0 70.0 71.0 90.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:110.00 stddev:22.10 (20.1%) stddev-sans-first:20.92 17:03:36 INFO - PID 1649 | Values: 88.0 98.0 134.0 84.0 127.0 136.0 95.0 134.0 132.0 136.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:97.00 stddev:21.54 (22.2%) stddev-sans-first:22.47 17:03:36 INFO - PID 1649 | Values: 97.0 97.0 105.0 97.0 96.0 98.0 97.0 146.0 151.0 96.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:92.50 stddev:1.66 (1.8%) stddev-sans-first:1.72 17:03:36 INFO - PID 1649 | Values: 93.0 95.0 93.0 92.0 93.0 92.0 91.0 90.0 90.0 90.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:51.00 stddev:11.52 (22.6%) stddev-sans-first:12.02 17:03:36 INFO - PID 1649 | Values: 51.0 49.0 48.0 50.0 51.0 51.0 49.0 69.0 76.0 75.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:63.00 stddev:12.05 (19.1%) stddev-sans-first:12.32 17:03:36 INFO - PID 1649 | Values: 57.0 66.0 58.0 60.0 84.0 85.0 80.0 56.0 57.0 58.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:95.90 Median:91.50 stddev:13.19 (14.4%) stddev-sans-first:13.86 17:03:36 INFO - PID 1649 | Values: 101.0 107.0 109.0 74.0 92.0 105.0 84.0 77.0 104.0 106.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:140.50 stddev:19.25 (13.7%) stddev-sans-first:20.40 17:03:36 INFO - PID 1649 | Values: 148.0 133.0 137.0 133.0 140.0 139.0 136.0 141.0 197.0 156.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:183.50 stddev:4.70 (2.6%) stddev-sans-first:4.97 17:03:36 INFO - PID 1649 | Values: 183.0 190.0 178.0 184.0 184.0 182.0 181.0 185.0 182.0 172.0 17:03:36 INFO - PID 1649 | 17:03:36 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:83.00 stddev:16.79 (20.2%) stddev-sans-first:17.61 17:03:36 INFO - PID 1649 | Values: 71.0 69.0 58.0 74.0 98.0 96.0 99.0 55.0 68.0 92.0 17:03:36 INFO - PID 1649 | -------- Summary: end -------- 17:03:36 INFO - PID 1649 | 17:03:37 INFO - TEST-INFO | 1649: exit 0 17:03:37 INFO - TEST-OK | kraken | took 61790ms 17:03:37 INFO - SUITE-END | took 1177s 17:03:37 INFO - Completed test suite (00:19:37) 17:03:37 INFO - javascript benchmark 17:03:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7831.6190994725275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2997.745191658709, 3579.6420357964207, 3614.945775813365, 3640.7451478396524, 3641.362761516734, 6074.757009719617, 6249.687515624218, 6255.311915689276, 6255.843603909904, 6273.059041143831, 6111.166351794765, 6125.449118208402, 6158.815235542929, 6191.721372538235, 6228.688565571726, 5373.731313434332, 5400.91898621521, 5433.755481003344, 5478.863028424302, 5518.33779946405, 5371.892562148755, 5453.2092846537225, 5517.282753242093, 5531.751071201806, 5531.834044978657, 5339.172428273624, 5378.300820893259, 5465.289512363367, 5469.56243500519, 5503.0, 5410.404855465896, 5412.566994640459, 5440.374356948962, 5448.264484294648, 5488.984537860469, 5331.5201631853315, 5372.892542149135, 5374.650647707926, 5378.46215378463, 5435.157550579666, 5148.712821794551, 5651.180578816049, 6067.7572897084065, 6108.706347746985, 6156.445919867188, 6634.834129146761, 6676.998450232455, 6688.732450701966, 6703.430208432241, 6710.261871194165, 6782.593044417302, 6788.389044985975, 6802.4217941475035, 6811.25076241613, 6815.897761533581, 6135.171422439398, 6149.846253843601, 6373.776917807901, 6387.776427825051, 6398.9040164397575, 6616.801495955129, 6821.590704557742, 6848.520603557803, 6907.792766217021, 6928.411085057826, 5635.971820140955, 5669.121286200645, 5788.88422231553, 6151.415615516608, 6394.072859435356, 5545.334559852843, 6679.699413526403, 6702.865942681216, 6736.1916570010935, 6743.0, 6369.5541312108635, 6426.132472116298, 6570.704318305688, 6646.734130634721, 6651.833704157338, 6430.5177111715875, 6566.212054553484, 6583.604983700993, 6644.534882558271, 6662.067310576524, 5299.6025298102795, 5305.283786688748, 5323.095073837457, 5335.653182543122, 5355.437679043722, 4689.179393606105, 4715.056988602293, 4716.457607375196, 4732.810687572527, 4755.738434386142, 6119.807225076679, 6180.103884936659, 6267.2792628847355, 6365.172527571479, 6423.325550817191, 6749.898751518731, 6766.458683305324, 6769.830754231184, 6781.593104413751, 6793.864122717518, 6326.557141000178, 6329.905051424233, 6342.8414289642205, 6376.266729326187, 6417.0, 5717.199592057115, 5778.479936805707, 5850.0, 5854.7072646367515, 5877.588568800228, 6912.308769123048, 6920.238773734885, 6946.270641582763, 6965.686544105426, 6972.721091156297, 6694.83262918431, 6767.154105736783, 6786.864262714619, 6795.082663840319, 6796.422304104009, 5630.4369563045, 6640.634765087773, 6743.460523158037, 6874.725010999504, 6902.551334163263, 6605.801825945229, 6671.499637527302, 6684.565503242468, 6685.164354455693, 6705.295943926013, 5624.74688639004, 6206.379362063757, 6783.525153239423, 6786.253512113763, 6807.421369183675, 6285.277193122666, 6295.496360291258, 6396.584222025554, 6518.054882042172, 6528.477721782341, 6477.222733272038, 6536.444402225674, 6542.803715888531, 6548.214214294315, 6552.213734351908, 5379.273798037371, 6201.441870231701, 6395.296517383177, 6407.391297826699, 6415.101885735908, 6294.339094395205, 6304.810855674337, 6360.0, 6466.708998095191, 6528.869422611616, 5248.947510524846, 6338.683065846782, 6395.776147834804, 6396.296407395276, 6407.0], "value": 6051.116276980121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.8048426924727, 805.8227190018196, 822.4078663362379, 1245.5142494427175, 1268.6638040919163, 36835.26329473409, 37844.864654060424, 37854.0, 37898.0, 37938.810305948435, 32418.8379058105, 36921.89234322968, 38016.619833801655, 38146.61853381465, 38226.617733822655, 6819.48853835963, 7707.190744971754, 8241.299489543397, 8446.408751387406, 8489.66041358345, 8388.748337549883, 8410.243078122967, 8427.367947403938, 8505.192006759378, 8514.233718965292, 8463.703770368038, 8493.532855692934, 8524.06235314115, 8524.403291769579, 8540.871886921701, 8444.282236009947, 8486.108958559385, 8487.872681909776, 8539.0, 8542.74371768848, 8360.163983601591, 8405.285550728195, 8414.49513029214, 8420.957895210484, 8425.915740842574, 36373.81813090944, 36437.27125457476, 36560.81719591412, 36593.81703091467, 36691.4496282556, 3049.329147587527, 3571.964280357189, 3578.4632305154173, 3578.946315805265, 3587.336342776595, 26259.606105908428, 29274.829006839915, 30419.935302264537, 30492.695073049206, 30569.082927511987, 2882.3802882380387, 3169.3978144152766, 3182.6499085100622, 3193.1857376369107, 3194.3132226571397, 287643.0, 306908.0, 308670.0, 311287.0, 311467.0, 47315.0, 47384.0, 47449.52550474451, 47540.762296188295, 47630.761846190544, 49101.754491227315, 49155.754221228664, 53132.734336328846, 53926.0, 54320.91358172814, 14120.0, 14217.0, 14224.21766802815, 14262.57212283633, 14280.928595357165, 9164.404313719588, 9381.155695987394, 11249.775004499865, 11331.546738130548, 11367.658970230907, 11600.955913967784, 13376.866231337563, 13810.309484525733, 13846.9614778892, 13848.584542463743, 6071.423214794588, 6080.513558915276, 6109.877802443926, 6111.083337499411, 6128.17269668598, 872.5855218771032, 989.1987490133015, 1001.1340190734962, 1014.3153371474225, 1035.6271742172812, 20182.0, 20535.691964620542, 24220.39449013789, 24514.877425612758, 24695.753042469347, 1042.2287507244585, 1127.3574062784298, 1145.9369734664674, 1149.6436104807538, 1158.4671051316489, 12492.375381230902, 12581.559645412366, 12688.87311126877, 12724.681882952815, 12774.914132298672, 314492.0, 314945.0, 315493.42253288586, 316347.4182629072, 317441.0, 53864.46135538673, 53874.7306263474, 54120.0, 54159.458405416226, 54257.0, 1446.6744982379091, 1461.3423959218394, 1503.639126609606, 1506.6685329227553, 1520.7718842173763, 23738.643920341554, 23828.642570361113, 23865.0, 23878.283651490485, 23888.761112388653, 37786.43320350142, 37795.81102094472, 37799.24401512009, 37893.0, 38027.80986095052, 273016.0, 273064.0, 273211.0, 273384.0, 274572.0, 27488.45023099567, 28262.869485221185, 33253.00240992774, 35064.948051558495, 36429.63570364368, 40994.1801163981, 41587.75236742903, 45382.77308613436, 45388.54611453843, 45456.0, 28916.27709307284, 29784.851075744482, 30572.541411878396, 31518.212044699067, 31719.0, 30488.695113049474, 30950.0, 30980.0, 31416.0, 31833.681663183073, 30149.34178620197, 30647.54028689527, 35536.93389198328, 36872.44691329686, 37599.248015040095, 25053.74946250514, 31286.530702039032, 31933.36133277275, 32115.83942080368, 32462.83768581142, 20369.69445458349, 21068.789312106685, 21525.92370381506, 24316.39209019718, 24371.39071523155], "value": 17291.175801870086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2313020219966, 431.7733190075212, 432.3190974215609, 440.89859332353547, 464.064909207946, 18236.361727339547, 20068.799312006875, 20761.896190519063, 20945.47636309093, 20951.37145885624, 17981.37065202718, 21253.787462125376, 21366.465838354048, 21612.351629451103, 21746.912654367297, 6009.549283803711, 6254.280072979944, 6315.368463153671, 6323.9051414228825, 6324.936750632503, 6012.308584512772, 6139.38606139387, 6188.938110618881, 6294.2761582417925, 6303.0, 6213.782517611885, 6266.342034086424, 6268.247810262752, 6272.2159730033745, 6285.717142728588, 6051.243594550681, 6129.601575897597, 6165.1677023601915, 6205.038219076027, 6231.750729970796, 5475.869680864299, 5480.095784195603, 5490.615656904019, 5504.422035686235, 5519.806806761784, 23871.522569548513, 26869.32826679329, 26907.86546067277, 27242.5913611296, 27451.90192392302, 2170.9565808683737, 2244.9775502244934, 2263.2870645746702, 2291.8395712300144, 2292.094622624071, 17539.912300438416, 17586.0, 17890.55273618157, 18081.909590452095, 18231.17959691817, 2159.5788821179717, 2207.4591725027312, 2223.1885361842974, 2227.9331620051425, 2233.2965115988573, 146417.0, 148052.0, 148090.0, 148477.0, 157898.63152052727, 12254.448549815279, 12833.871661283454, 12894.80657790134, 12907.096503244682, 12941.417636206394, 13606.727865442635, 13699.383527741076, 16166.43417480406, 16445.91777041107, 16472.0, 8764.298856091498, 8959.686410975715, 8962.73111806647, 9001.954990225007, 9100.544972751335, 8435.0, 8480.957595211985, 8532.744017679479, 8635.309175265964, 8636.95681521601, 6479.546431749733, 7745.91557181995, 7802.180771019075, 7827.9608601956625, 7889.566073865993, 2166.155199472207, 2181.4328274648706, 2184.6395344767934, 2188.7811218877987, 2332.323626148398, 972.1493693018608, 990.1880458024351, 994.3188915592842, 1008.2287050406445, 1030.6907927621833, 19410.32063877786, 19511.90244048799, 19743.012849357474, 20129.698054529195, 20538.486537836674, 1001.2390583156707, 1022.5602990713916, 1026.7997740440692, 1033.6743925663393, 1037.6990672704983, 10421.843672344921, 10693.625723099654, 10705.0, 10720.946395267974, 10738.463076846127, 559048.0, 565458.0725156504, 569562.0, 571281.0, 572759.0, 102808.0, 103119.93760124755, 125761.37119314345, 127436.3581910737, 127650.0, 1158.2182027131653, 1181.5155786127818, 1194.6654936617588, 1248.36333469931, 1250.737345157509, 20265.30795028222, 21338.35984920455, 21367.8931605341, 21375.572488550453, 21532.246371377554, 50026.49973500364, 51744.0, 55814.0, 56371.154432684365, 57752.0, 76378.03542769702, 77643.61178194072, 77853.61073194598, 79442.60278698569, 79449.0, 8718.08460111679, 8805.0, 9127.178553930178, 9240.399374040666, 12805.551805686757, 13879.444822206999, 14151.363188656742, 14157.292135393394, 14792.704145916807, 14951.626209344853, 11538.826917596074, 11848.585299514476, 11958.0, 12075.335856527976, 12145.570885823048, 10557.0, 10768.030877221088, 11040.779184416106, 11150.553977840795, 11661.300321980709, 9524.571394287412, 12071.094667900119, 12107.636770896886, 12254.754904901674, 12364.381780910739, 12798.680032998876, 13227.148199252304, 13271.412074645352, 13370.130941488773, 13485.056046076681, 10920.853310402294, 11889.464974076014, 12057.57798477049, 12111.515539378326, 12132.0], "value": 10550.955777904945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.8998370114093, 1467.787170860226, 1470.7352676518221, 1480.5046902628342, 1494.8654621084104, 11424.657260282194, 11886.227395219305, 11919.702007449818, 11920.701982450442, 12271.509139634427, 11987.520499180022, 12011.339376334297, 12142.757144857098, 12154.33151176685, 12157.635270941864, 2077.24180674054, 2577.497388009339, 2577.9484410311784, 2584.728603496634, 2587.081586036958, 2499.8750062496892, 2526.570483017882, 2533.1134103063873, 2536.568783306833, 2552.438463538019, 2501.17461237792, 2531.5696331623667, 2540.2252313044514, 2543.1480454047914, 2553.6297236900637, 2128.0, 2476.3561474016706, 2513.321403221129, 2543.2878793937543, 2545.5290771207387, 2045.1614837916384, 2440.12155623977, 2441.2676197140963, 2444.8899799508886, 2446.7797898189247, 10442.947785261025, 11168.385738784364, 11686.649400517997, 11919.582814601534, 11959.940200298943, 6709.429698475636, 6955.269696681826, 6958.304169583002, 6959.408450281732, 6976.476764242651, 4087.4686290782006, 4413.0732546165345, 4468.2850743881145, 4481.395011673415, 4518.43519560055, 1235.2279825109306, 1249.900007999358, 1286.9549565765153, 1314.9802752958713, 1317.7562151002096, 14308.57074287773, 16090.919545402197, 16235.107069111195, 16680.916595417068, 17053.573660658458, 5586.664800112007, 5813.854653633608, 5916.970415147983, 5970.373110823388, 5975.731092100779, 10094.394336339843, 12452.626421207378, 12505.812412813815, 12508.499660013498, 12537.498500059895, 6718.596884186964, 6725.66371681414, 6726.22648395431, 6735.494837887178, 6755.763548275787, 6050.273967123973, 6263.843403914939, 6269.216347956505, 6336.20797400325, 6337.207849018872, 4362.781860906942, 4433.778311084433, 4449.509414346166, 4510.300903359985, 4543.182227199136, 1286.7362190750873, 1311.7573248948975, 1311.8360204974379, 1327.6879933215687, 1328.93355332233, 773.9148693643695, 795.9135186505196, 803.5339503088195, 812.1837553258937, 818.300353198019, 6260.718267677874, 6263.530235232376, 6423.96788016057, 6493.350664933469, 6505.447037001813, 504.553470178887, 585.4409039367393, 594.5629961977943, 597.1430996520007, 614.5126407636644, 4067.8372865085066, 4214.17823524416, 4318.114786468766, 4392.758398288125, 4476.0, 14822.88719368923, 15094.094354338775, 15110.320035598425, 15305.540833774781, 15326.846731532765, 14914.403423862925, 15262.0, 15324.693506129815, 15332.463363782213, 15349.002314849498, 7629.580373079423, 8610.311175105977, 8727.825443491094, 8734.95632521846, 8761.868571971425, 5658.519025882846, 6251.624902505864, 6396.520260980352, 6820.488463365168, 7223.638818059181, 12619.11666183395, 12646.683832904251, 12654.240745555297, 12735.80896286538, 12895.48418063267, 11601.593944211912, 13133.868661313647, 13309.136720858894, 13924.860751392356, 14066.296685165906, 8606.612702428281, 8809.339299552686, 8849.24781393563, 8864.113588641343, 8866.512341821262, 10819.891801081889, 10831.566737330419, 10858.565657373616, 10932.234743568191, 10964.232503724663, 9246.398984066014, 9269.953650231706, 9277.814443710953, 9289.21041711462, 9342.673006444742, 8892.73321800347, 9048.819023619359, 9079.0, 9089.545522723969, 9179.770505737142, 8209.932708747825, 8239.340852731886, 8249.133840946613, 8329.208725171098, 8350.164983501601, 5212.348456442945, 6027.095935609694, 6156.753729850756, 6212.596181248205, 6274.152989346379, 6022.277326720821, 6111.8777624446375, 6114.816555503342, 6278.529110316836, 6465.2564955030775], "value": 5345.331102004352, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.7235438433441, 416.084613849531, 419.702011571784, 421.65424352031346, 427.7027465911193, 5849.830033993202, 6144.0, 6232.880820521022, 6301.180846489956, 6374.418360563967, 5072.315237442944, 6110.450059494645, 6150.815475535741, 6217.5958562693395, 6219.533534984883, 3847.8845634631007, 4369.847055353063, 4549.749763762991, 4587.42657167854, 4745.881352966169, 4570.268756998881, 4574.931376029345, 4578.175928332898, 4578.450585929693, 4605.401297831278, 4123.9793801030955, 4531.365608814768, 4552.133625213663, 4556.84051058213, 4575.496695363508, 4441.689081764262, 4501.684882058257, 4516.7578915798085, 4534.455865296152, 4548.135854187693, 3861.1119442528375, 3865.864694735699, 3873.748206366577, 3886.6113388661192, 3889.7860617666015, 5242.580593552545, 6113.908291375633, 6123.2652081750475, 6126.142340072349, 6153.2000839890525, 5264.710440925747, 5422.674639521641, 5424.511793938525, 5479.1781232815, 5479.506844383985, 5730.68481233532, 6654.733810647568, 6680.83297917551, 6681.966590167067, 6688.565243259172, 4342.761148136851, 4444.177827101964, 4456.353828694853, 4475.776211189427, 4484.2376795944765, 6174.691265436711, 6755.729770809162, 6764.666190164386, 6959.1996920353795, 6992.021117043618, 4280.379344994958, 4309.827606895689, 4424.778761061998, 4518.548145185455, 4538.455385353779, 4134.524529679125, 4147.880072380441, 4496.19068567661, 4546.499885012646, 4613.746243956548, 4435.489918659331, 4919.704817710949, 5032.748362581856, 5200.2979597754575, 5463.508284254436, 5845.09401042839, 6387.041943708481, 6675.632840193739, 6719.664016799238, 6736.8989465158065, 1362.9659258518418, 1426.6504706347012, 1544.5752418085117, 1571.8035245594301, 1580.0519688186996, 1011.9241056920761, 1019.2406657040552, 1031.9122874555746, 1034.4724190662816, 1045.8535804987307, 5569.8024924641395, 5875.795461930294, 6392.776252831129, 6396.776112836028, 6419.711112999927, 6914.0, 6932.306769323028, 6966.989786480932, 6984.61584612841, 6992.755253566101, 5006.1739812930455, 5057.898842023139, 5712.400197979236, 6052.455279024909, 6334.651594162366, 2981.0, 3027.8940237091597, 3133.6396314424132, 3325.434676105068, 3607.5310209672575, 6291.5281353898645, 6793.98090286461, 6917.654117294115, 7090.255523170096, 7108.822279443055, 5537.916931246034, 6698.0, 6722.890723030743, 6820.761273355409, 7063.399611033017, 6832.829179270459, 7012.789616311621, 7037.683304251424, 7111.573305601681, 7111.715531378687, 6903.1716194057035, 6913.481488888454, 6915.723371065303, 6927.134108236471, 6973.6164510952385, 6454.386833250834, 6695.852949113909, 6734.8653026940165, 6736.259011508828, 6822.897656535255, 6401.583897046677, 6607.141071660653, 7020.0, 7228.674709637974, 7291.203493222794, 4019.1358857845703, 4556.0, 4564.360989461412, 4568.840090596813, 4589.334546490807, 6595.637239951657, 6774.933645238052, 6892.207396149507, 7007.789766307019, 7026.508144429841, 5245.950809837971, 6187.978983467678, 6325.841853953504, 6724.226713927961, 6781.321867813179, 5548.306461692288, 6468.062130991074, 6608.173978252718, 6694.497912656473, 6723.4285085766305, 5766.682832444256, 5943.7518121195035, 5981.401859814157, 6070.696465176812, 6582.76960306387, 5471.932973070213, 5521.889562208814, 6056.0, 6695.4308883745425, 6734.865302693821, 5300.9734951325, 5468.972655136698, 6451.387118223761, 6519.762154599548, 6551.44312733423], "value": 4792.9726221194105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.116434251009, 832.604512856393, 842.3387640702048, 852.441650718779, 855.7005048233117, 15874.920625396871, 16247.43133990309, 16280.511584652464, 18486.352977645784, 19151.329703460382, 17527.91236043818, 17564.560885977826, 17705.55736106598, 17747.91126044368, 18002.09989500523, 935.9906400935988, 960.4045491795061, 964.4406244378243, 966.3284017607765, 966.7921396899665, 956.077385323163, 959.94720290384, 964.344245912779, 964.9083337083001, 965.4255717847869, 1017.653997640802, 1037.3516552154904, 1038.9220808439359, 1038.9480525973709, 1040.5629635553048, 1013.4324778124237, 1028.8611037509916, 1032.5560009196006, 1032.901874321942, 1036.5542816588863, 669.6752075243503, 712.479889680531, 729.9781006569812, 741.8850078237828, 745.9925400746032, 16334.75497867533, 16439.589010274718, 16467.505974820775, 16515.91742041282, 16532.421365252158, 16092.195390230441, 16437.506874793777, 16741.567978564366, 16921.915390422968, 16930.322787088502, 13675.31623418835, 13859.37632806516, 13910.791338129937, 13981.650458738512, 13985.021048526607, 3452.9482057769155, 3460.8615655373756, 3517.718582513393, 3520.7359448041498, 3523.3129539739502, 99466.50800238003, 100271.99999999927, 124800.0, 125977.0, 127152.0, 13229.272390018641, 13426.328683565978, 13487.0, 13516.459341626225, 13561.711637394432, 18580.349687760863, 25172.24483265505, 25717.74282257191, 25725.485490290088, 25731.0, 5092.541671249532, 6365.395287447685, 6417.9679101605125, 6422.903656445157, 6462.0, 3966.2662407454714, 4040.676745860324, 4044.3326851069833, 4063.5733248009124, 4074.124063326399, 4115.156392939441, 4330.0906809569715, 4361.01877077655, 4394.846180383671, 4451.020775429401, 925.5603588295505, 925.847235206197, 936.8313703533294, 950.7860731335394, 951.9762005949907, 612.3233826621608, 617.6658417817492, 624.7844493649684, 624.9875002500015, 658.7266284491978, 10961.780764384826, 10974.451277436256, 12042.458089385998, 12056.819147712791, 12147.331896745587, 600.5915977135589, 609.3632154398664, 610.5390430225241, 634.501915995941, 637.5632691606264, 5407.0, 5561.026820306511, 5596.748146333425, 5710.543156547466, 5728.570357223141, 102847.4857625722, 105881.47059264808, 105895.47052264844, 106665.46667266614, 108948.0, 85964.57017714871, 89946.55026724824, 92281.53859230794, 93387.53306233426, 94124.52937735405, 58281.0, 60983.69508152431, 80161.0, 81256.0, 81392.59303703562, 10058.647947321808, 10568.894311057098, 10873.130149587856, 11302.491387887729, 11498.195126341076, 42131.789341054326, 42230.577694223895, 42626.78686606547, 43227.78386108049, 43589.12821743611, 53880.0, 54234.64413389539, 54339.3698189055, 54386.728066361, 55672.44327556673, 10750.139988801033, 11778.0, 12713.36433178356, 13907.165570065828, 13932.02475826723, 18077.186526606598, 18681.53296167607, 18702.53243668865, 18764.906175469034, 18818.905905470932, 16330.673386531966, 16595.668086637957, 16966.830331696525, 17178.39875604348, 17458.30166793314, 16659.25033373477, 16685.08232047249, 16844.410445634345, 17104.315827366765, 17348.39280625172, 14538.85461145375, 14558.854411456174, 14603.926980365455, 14680.926595366955, 14700.191489468181, 11584.304941703525, 11883.524659013543, 11937.343446110548, 12088.637340879788, 12102.971247443713, 13139.802902956271, 13554.525591604246, 13587.360779140812, 13758.65603359924, 13772.246248280973], "value": 8157.32073135355, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 148.0, 149.0, 105.0, 113.0, 109.0, 122.0, 150.0, 143.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 190.0, 257.0, 267.0, 260.0, 232.0, 214.0, 239.0, 207.0, 243.0], "value": 229.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 55.0, 59.0, 97.0, 50.0, 49.0, 70.0, 88.0, 94.0, 90.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 72.0, 105.0, 71.0, 69.0, 70.0, 88.0, 70.0, 71.0, 90.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 98.0, 134.0, 84.0, 127.0, 136.0, 95.0, 134.0, 132.0, 136.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 105.0, 97.0, 96.0, 98.0, 97.0, 146.0, 151.0, 96.0], "value": 108.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 92.0, 93.0, 92.0, 91.0, 90.0, 90.0, 90.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 48.0, 50.0, 51.0, 51.0, 49.0, 69.0, 76.0, 75.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 66.0, 58.0, 60.0, 84.0, 85.0, 80.0, 56.0, 57.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 109.0, 74.0, 92.0, 105.0, 84.0, 77.0, 104.0, 106.0], "value": 95.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 133.0, 137.0, 133.0, 140.0, 139.0, 136.0, 141.0, 197.0, 156.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 190.0, 178.0, 184.0, 184.0, 182.0, 181.0, 185.0, 182.0, 172.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 58.0, 74.0, 98.0, 96.0, 99.0, 55.0, 68.0, 92.0], "value": 78.0, "unit": "score"}]}]} 17:03:37 INFO - Return code: 0 17:03:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:03:37 ERROR - # TBPL SUCCESS # 17:03:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:03:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:03:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:03:37 INFO - 2017-04-24 17:03:37.523 screenresolution[1654:10667] starting screenresolution argv=screenresolution get 17:03:37 INFO - 2017-04-24 17:03:37.526 screenresolution[1654:10667] Display 0: 1600x1200x32@60 17:03:37 INFO - 2017-04-24 17:03:37.532 screenresolution[1655:10670] starting screenresolution argv=screenresolution list 17:03:37 INFO - Available Modes on Display 0 17:03:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:03:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:03:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:03:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:03:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:03:37 INFO - Intel Iris: 17:03:37 INFO - Chipset Model: Intel Iris 17:03:37 INFO - Type: GPU 17:03:37 INFO - Bus: Built-In 17:03:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:03:37 INFO - Vendor: Intel (0x8086) 17:03:37 INFO - Device ID: 0x0a2e 17:03:37 INFO - Revision ID: 0x0009 17:03:37 INFO - Displays: 17:03:37 INFO - Display: 17:03:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:03:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:03:37 INFO - Display Serial Number: 1600x1200 60 17:03:37 INFO - Main Display: Yes 17:03:37 INFO - Mirror: Off 17:03:37 INFO - Online: Yes 17:03:37 INFO - Rotation: Supported 17:03:37 INFO - Return code: 0 17:03:37 INFO - Running post-action listener: _resource_record_post_action 17:03:37 INFO - [mozharness: 2017-04-25 00:03:37.784338Z] Finished run-tests step (success) 17:03:37 INFO - Running post-run listener: _resource_record_post_run 17:03:37 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38234624; Write bytes: 508397568; Read time: 451; Write time: 1845 17:03:37 INFO - TinderboxPrint: CPU usage
54.3% 17:03:37 INFO - TinderboxPrint: I/O read bytes / time
38,234,624 / 451 17:03:37 INFO - TinderboxPrint: I/O write bytes / time
508,397,568 / 1,845 17:03:37 INFO - TinderboxPrint: CPU idle
2,188.6 (45.7%) 17:03:37 INFO - TinderboxPrint: CPU system
968.4 (20.2%) 17:03:37 INFO - TinderboxPrint: CPU user
1,632.6 (34.1%) 17:03:37 INFO - TinderboxPrint: Swap in / out
246,444,032 / 0 17:03:37 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209228288; Write bytes: 210618368; Read time: 16028; Write time: 401 17:03:37 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35277312; Write bytes: 296443904; Read time: 354; Write time: 1438 17:03:38 INFO - Running post-run listener: _upload_blobber_files 17:03:38 INFO - Blob upload gear active. 17:03:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:03:38 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 17:03:38 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'] 17:03:38 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 17:03:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:03:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:03:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:39 INFO - (blobuploader) - INFO - Done attempting. 17:03:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:03:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:40 INFO - (blobuploader) - INFO - Done attempting. 17:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:41 INFO - (blobuploader) - INFO - Done attempting. 17:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:43 INFO - (blobuploader) - INFO - Done attempting. 17:03:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:03:43 INFO - Return code: 0 17:03:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:03:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:03:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c861a2f508f914e9cb9567c54e3e9f5cabfa3cc3217f6eae1b84fca1d8cf8e087a616b21fa920c5f54bb203ffa91f86b9c00801ae8110b4fa53933e1b99a6489", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/658edef0a6826558b55bc2b439848047222725f5a9964eb9c6507dd7703ad59cc3ce87c7be7c5789852f5e7cfa753eaaab1abc653e86ad326095fe35a8416cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44e927f0418c9076395ee19b33703f7ff15a1270d4d03c845f8ea43499620e456959deb9eb29d86c437b1b9c93d1d8904e4ef3d79f45bfcb244a478f7302706", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f420085a96a66f9b4a8a48171348530443e3248b3adc3893b2a54d6e9d86c7b1214463abfad6e95680137e7a560d4f0f3b77f7c2ceef714ef0ec3e97b2a323ac"} 17:03:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:03:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:03:43 INFO - Contents: 17:03:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c861a2f508f914e9cb9567c54e3e9f5cabfa3cc3217f6eae1b84fca1d8cf8e087a616b21fa920c5f54bb203ffa91f86b9c00801ae8110b4fa53933e1b99a6489", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/658edef0a6826558b55bc2b439848047222725f5a9964eb9c6507dd7703ad59cc3ce87c7be7c5789852f5e7cfa753eaaab1abc653e86ad326095fe35a8416cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44e927f0418c9076395ee19b33703f7ff15a1270d4d03c845f8ea43499620e456959deb9eb29d86c437b1b9c93d1d8904e4ef3d79f45bfcb244a478f7302706", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f420085a96a66f9b4a8a48171348530443e3248b3adc3893b2a54d6e9d86c7b1214463abfad6e95680137e7a560d4f0f3b77f7c2ceef714ef0ec3e97b2a323ac"} 17:03:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:03:43 INFO - Copying logs to upload dir... 17:03:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:03:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.296299 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-24 17:03:43.918901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:43.922347) ========= 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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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/c861a2f508f914e9cb9567c54e3e9f5cabfa3cc3217f6eae1b84fca1d8cf8e087a616b21fa920c5f54bb203ffa91f86b9c00801ae8110b4fa53933e1b99a6489", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/658edef0a6826558b55bc2b439848047222725f5a9964eb9c6507dd7703ad59cc3ce87c7be7c5789852f5e7cfa753eaaab1abc653e86ad326095fe35a8416cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44e927f0418c9076395ee19b33703f7ff15a1270d4d03c845f8ea43499620e456959deb9eb29d86c437b1b9c93d1d8904e4ef3d79f45bfcb244a478f7302706", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f420085a96a66f9b4a8a48171348530443e3248b3adc3893b2a54d6e9d86c7b1214463abfad6e95680137e7a560d4f0f3b77f7c2ceef714ef0ec3e97b2a323ac"} build_url:https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011047 build_url: 'https://queue.taskcluster.net/v1/task/FNirp4gJS_uKHF5O1GZKmg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c861a2f508f914e9cb9567c54e3e9f5cabfa3cc3217f6eae1b84fca1d8cf8e087a616b21fa920c5f54bb203ffa91f86b9c00801ae8110b4fa53933e1b99a6489", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/658edef0a6826558b55bc2b439848047222725f5a9964eb9c6507dd7703ad59cc3ce87c7be7c5789852f5e7cfa753eaaab1abc653e86ad326095fe35a8416cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44e927f0418c9076395ee19b33703f7ff15a1270d4d03c845f8ea43499620e456959deb9eb29d86c437b1b9c93d1d8904e4ef3d79f45bfcb244a478f7302706", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f420085a96a66f9b4a8a48171348530443e3248b3adc3893b2a54d6e9d86c7b1214463abfad6e95680137e7a560d4f0f3b77f7c2ceef714ef0ec3e97b2a323ac"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:43.958893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:43.959289) ========= 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.xDkCUyNMw8/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.RLu1aDsg7L/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.005034 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 17:03:44.010028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 17:03:44.010526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 17:03:44.011212) ========= ========= Total master_lag: 1.16 =========